{"level":"warn","ts":"2026-02-18T14:38:07.040926Z","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-18T14:38:07.04102Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.62: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.62:2380","--initial-cluster=instance=https://162.253.55.62:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.62:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.62: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-18T14:38:07.041089Z","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-18T14:38:07.041109Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.62:2380"]} {"level":"info","ts":"2026-02-18T14:38:07.041136Z","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-18T14:38:07.041699Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"]} {"level":"info","ts":"2026-02-18T14:38:07.041808Z","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.62:2380"],"listen-peer-urls":["https://162.253.55.62:2380"],"advertise-client-urls":["https://162.253.55.62:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.62: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-18T14:38:07.04632Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.296237ms"} {"level":"info","ts":"2026-02-18T14:38:07.058005Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"791a7e25b533cd26","cluster-id":"be484d2748da72cd"} {"level":"info","ts":"2026-02-18T14:38:07.058153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=()"} {"level":"info","ts":"2026-02-18T14:38:07.058222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became follower at term 0"} {"level":"info","ts":"2026-02-18T14:38:07.058323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 791a7e25b533cd26 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-18T14:38:07.05838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became follower at term 1"} {"level":"info","ts":"2026-02-18T14:38:07.058472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=(8726425928402717990)"} {"level":"warn","ts":"2026-02-18T14:38:07.064553Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-18T14:38:07.066373Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-18T14:38:07.068777Z","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-18T14:38:07.076372Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"791a7e25b533cd26","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-18T14:38:07.083339Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"791a7e25b533cd26","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-18T14:38:07.083462Z","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-18T14:38:07.083526Z","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-18T14:38:07.083573Z","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-18T14:38:07.084458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=(8726425928402717990)"} {"level":"info","ts":"2026-02-18T14:38:07.084575Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"be484d2748da72cd","local-member-id":"791a7e25b533cd26","added-peer-id":"791a7e25b533cd26","added-peer-peer-urls":["https://162.253.55.62:2380"]} {"level":"info","ts":"2026-02-18T14:38:07.084776Z","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-18T14:38:07.084812Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.62:2380"} {"level":"info","ts":"2026-02-18T14:38:07.087011Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.62:2380"} {"level":"info","ts":"2026-02-18T14:38:07.088391Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"791a7e25b533cd26","initial-advertise-peer-urls":["https://162.253.55.62:2380"],"listen-peer-urls":["https://162.253.55.62:2380"],"advertise-client-urls":["https://162.253.55.62:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-18T14:38:07.088461Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-18T14:38:07.259326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 is starting a new election at term 1"} {"level":"info","ts":"2026-02-18T14:38:07.259449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-18T14:38:07.259516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 received MsgPreVoteResp from 791a7e25b533cd26 at term 1"} {"level":"info","ts":"2026-02-18T14:38:07.259567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became candidate at term 2"} {"level":"info","ts":"2026-02-18T14:38:07.259623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 received MsgVoteResp from 791a7e25b533cd26 at term 2"} {"level":"info","ts":"2026-02-18T14:38:07.259658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became leader at term 2"} {"level":"info","ts":"2026-02-18T14:38:07.259725Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 791a7e25b533cd26 elected leader 791a7e25b533cd26 at term 2"} {"level":"info","ts":"2026-02-18T14:38:07.261568Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"791a7e25b533cd26","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.62:2379]}","request-path":"/0/members/791a7e25b533cd26/attributes","cluster-id":"be484d2748da72cd","publish-timeout":"7s"} {"level":"info","ts":"2026-02-18T14:38:07.261661Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-18T14:38:07.261942Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T14:38:07.262128Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-18T14:38:07.262317Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-18T14:38:07.262392Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-18T14:38:07.266696Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-18T14:38:07.275309Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"be484d2748da72cd","local-member-id":"791a7e25b533cd26","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T14:38:07.275394Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T14:38:07.275417Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T14:38:07.275182Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.62:2379"} {"level":"warn","ts":"2026-02-18T14:38:11.573244Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674836838208412,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T14:38:13.601501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00055987s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-18T14:38:13.602164Z","caller":"traceutil/trace.go:171","msg":"trace[472195296] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000999334s","start":"2026-02-18T14:38:11.600872Z","end":"2026-02-18T14:38:13.601871Z","steps":["trace[472195296] 'agreement among raft nodes before linearized reading' (duration: 2.000589211s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:13.602338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:11.600854Z","time spent":"2.00145501s","remote":"127.0.0.1:54154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/18 14:38:13 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-18T14:38:13.789875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.114000509s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-18T14:38:13.790039Z","caller":"traceutil/trace.go:171","msg":"trace[1834281757] linearizableReadLoop","detail":"{readStateIndex:178; appliedIndex:177; }","duration":"2.716933688s","start":"2026-02-18T14:38:11.07306Z","end":"2026-02-18T14:38:13.789993Z","steps":["trace[1834281757] 'read index received' (duration: 601.268712ms)","trace[1834281757] 'applied index is now lower than readState.Index' (duration: 2.115663716s)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:13.791202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.718125148s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:pod-garbage-collector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:38:13.79125Z","caller":"traceutil/trace.go:171","msg":"trace[930638284] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:pod-garbage-collector; range_end:; response_count:0; response_revision:172; }","duration":"2.718179269s","start":"2026-02-18T14:38:11.073057Z","end":"2026-02-18T14:38:13.791236Z","steps":["trace[930638284] 'agreement among raft nodes before linearized reading' (duration: 2.718066646s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:13.791338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:11.073032Z","time spent":"2.718294323s","remote":"127.0.0.1:54536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":28,"request content":"key:\"/registry/clusterrolebindings/system:controller:pod-garbage-collector\" "} {"level":"info","ts":"2026-02-18T14:38:13.790651Z","caller":"traceutil/trace.go:171","msg":"trace[234291441] transaction","detail":"{read_only:false; response_revision:172; number_of_response:1; }","duration":"2.723174493s","start":"2026-02-18T14:38:11.067462Z","end":"2026-02-18T14:38:13.790637Z","steps":["trace[234291441] 'process raft request' (duration: 606.905548ms)","trace[234291441] 'compare' (duration: 2.113024206s)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:13.791947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:11.067453Z","time spent":"2.724306272s","remote":"127.0.0.1:54252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-18T14:38:14.290907Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674836838208417,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T14:38:14.644345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999894455s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-18T14:38:14.644402Z","caller":"traceutil/trace.go:171","msg":"trace[1196980017] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999993378s","start":"2026-02-18T14:38:12.644396Z","end":"2026-02-18T14:38:14.644389Z","steps":["trace[1196980017] 'agreement among raft nodes before linearized reading' (duration: 1.999924026s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:14.644433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:12.64438Z","time spent":"2.00004802s","remote":"127.0.0.1:54154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-18T14:38:14.791826Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674836838208417,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T14:38:14.816374Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.078874275s","expected-duration":"1s"} {"level":"info","ts":"2026-02-18T14:38:14.894954Z","caller":"traceutil/trace.go:171","msg":"trace[1643675776] linearizableReadLoop","detail":"{readStateIndex:182; appliedIndex:178; }","duration":"1.104374729s","start":"2026-02-18T14:38:13.790557Z","end":"2026-02-18T14:38:14.894931Z","steps":["trace[1643675776] 'read index received' (duration: 1.025958363s)","trace[1643675776] 'applied index is now lower than readState.Index' (duration: 78.415346ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:38:14.895037Z","caller":"traceutil/trace.go:171","msg":"trace[1834424072] transaction","detail":"{read_only:false; response_revision:176; number_of_response:1; }","duration":"266.789392ms","start":"2026-02-18T14:38:14.628238Z","end":"2026-02-18T14:38:14.895027Z","steps":["trace[1834424072] 'process raft request' (duration: 266.663398ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:38:14.895066Z","caller":"traceutil/trace.go:171","msg":"trace[2101242370] transaction","detail":"{read_only:false; response_revision:173; number_of_response:1; }","duration":"2.157678975s","start":"2026-02-18T14:38:12.737356Z","end":"2026-02-18T14:38:14.895035Z","steps":["trace[2101242370] 'process raft request' (duration: 2.079201186s)","trace[2101242370] 'compare' (duration: 77.720504ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:14.895213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:12.73733Z","time spent":"2.157819829s","remote":"127.0.0.1:54382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5476,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-18T14:38:14.895279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.292374659s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:38:14.895313Z","caller":"traceutil/trace.go:171","msg":"trace[1617389034] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:176; }","duration":"1.292462362s","start":"2026-02-18T14:38:13.602841Z","end":"2026-02-18T14:38:14.895303Z","steps":["trace[1617389034] 'agreement among raft nodes before linearized reading' (duration: 1.292371289s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:14.895344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:13.602808Z","time spent":"1.292529404s","remote":"127.0.0.1:54168","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-18T14:38:14.895415Z","caller":"traceutil/trace.go:171","msg":"trace[1487675102] transaction","detail":"{read_only:false; response_revision:174; number_of_response:1; }","duration":"1.099987061s","start":"2026-02-18T14:38:13.795417Z","end":"2026-02-18T14:38:14.895404Z","steps":["trace[1487675102] 'process raft request' (duration: 1.09937016s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:14.895474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.38223043s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:38:14.895504Z","caller":"traceutil/trace.go:171","msg":"trace[660612736] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:176; }","duration":"2.382285192s","start":"2026-02-18T14:38:12.513211Z","end":"2026-02-18T14:38:14.895496Z","steps":["trace[660612736] 'agreement among raft nodes before linearized reading' (duration: 2.38224156s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:14.895533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:12.513196Z","time spent":"2.382331203s","remote":"127.0.0.1:54450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-18T14:38:14.895573Z","caller":"traceutil/trace.go:171","msg":"trace[1038726409] transaction","detail":"{read_only:false; response_revision:175; number_of_response:1; }","duration":"1.100087564s","start":"2026-02-18T14:38:13.795476Z","end":"2026-02-18T14:38:14.895564Z","steps":["trace[1038726409] 'process raft request' (duration: 1.099373901s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:14.895618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:13.795471Z","time spent":"1.100126325s","remote":"127.0.0.1:54536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":744,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-18T14:38:14.895681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.237185817s","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-18T14:38:14.895711Z","caller":"traceutil/trace.go:171","msg":"trace[494275644] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:176; }","duration":"3.237213869s","start":"2026-02-18T14:38:11.658488Z","end":"2026-02-18T14:38:14.895701Z","steps":["trace[494275644] 'agreement among raft nodes before linearized reading' (duration: 3.237146555s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:14.895736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:11.658461Z","time spent":"3.237269031s","remote":"127.0.0.1:54450","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-18T14:38:14.895852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.237487748s","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-18T14:38:14.895877Z","caller":"traceutil/trace.go:171","msg":"trace[196161538] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:176; }","duration":"3.23754409s","start":"2026-02-18T14:38:11.658325Z","end":"2026-02-18T14:38:14.895869Z","steps":["trace[196161538] 'agreement among raft nodes before linearized reading' (duration: 3.237504379s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:14.895903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:11.658306Z","time spent":"3.237589231s","remote":"127.0.0.1:54450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-18T14:38:14.895472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:13.795402Z","time spent":"1.100042652s","remote":"127.0.0.1:54252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":636,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-18T14:38:14.896074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.047211589s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:38:14.896123Z","caller":"traceutil/trace.go:171","msg":"trace[1006437423] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:176; }","duration":"1.047297142s","start":"2026-02-18T14:38:13.848812Z","end":"2026-02-18T14:38:14.896109Z","steps":["trace[1006437423] 'agreement among raft nodes before linearized reading' (duration: 1.047213459s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:14.896161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:13.848779Z","time spent":"1.047373135s","remote":"127.0.0.1:54450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-18T14:38:17.921754Z","caller":"traceutil/trace.go:171","msg":"trace[619097625] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"124.421317ms","start":"2026-02-18T14:38:17.797307Z","end":"2026-02-18T14:38:17.921728Z","steps":["trace[619097625] 'process raft request' (duration: 74.52028ms)","trace[619097625] 'compare' (duration: 49.792144ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:18.524325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.430966ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-18T14:38:18.52441Z","caller":"traceutil/trace.go:171","msg":"trace[714214234] linearizableReadLoop","detail":"{readStateIndex:312; appliedIndex:311; }","duration":"324.02317ms","start":"2026-02-18T14:38:18.200373Z","end":"2026-02-18T14:38:18.524396Z","steps":["trace[714214234] 'read index received' (duration: 13.597363ms)","trace[714214234] 'applied index is now lower than readState.Index' (duration: 310.424497ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:38:18.524534Z","caller":"traceutil/trace.go:171","msg":"trace[419626284] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"324.848367ms","start":"2026-02-18T14:38:18.199678Z","end":"2026-02-18T14:38:18.524526Z","steps":["trace[419626284] 'process raft request' (duration: 14.282494ms)","trace[419626284] 'compare' (duration: 309.275071ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:18.524569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:18.199665Z","time spent":"324.887307ms","remote":"127.0.0.1:54522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":373,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-18T14:38:18.524729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.33111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:1 size:205"} {"level":"info","ts":"2026-02-18T14:38:18.524829Z","caller":"traceutil/trace.go:171","msg":"trace[12437975] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:1; response_revision:305; }","duration":"324.468005ms","start":"2026-02-18T14:38:18.200343Z","end":"2026-02-18T14:38:18.524811Z","steps":["trace[12437975] 'agreement among raft nodes before linearized reading' (duration: 324.227417ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:18.524871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:18.200336Z","time spent":"324.525406ms","remote":"127.0.0.1:54390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":228,"request content":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" "} {"level":"info","ts":"2026-02-18T14:38:18.58108Z","caller":"traceutil/trace.go:171","msg":"trace[1011992629] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"379.259567ms","start":"2026-02-18T14:38:18.201799Z","end":"2026-02-18T14:38:18.581059Z","steps":["trace[1011992629] 'process raft request' (duration: 379.125533ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:18.581187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:18.201793Z","time spent":"379.34747ms","remote":"127.0.0.1:54252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-18T14:38:19.330306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.337163ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-02-18T14:38:19.331404Z","caller":"traceutil/trace.go:171","msg":"trace[254183364] transaction","detail":"{read_only:false; number_of_response:0; response_revision:306; }","duration":"1.050594259s","start":"2026-02-18T14:38:18.280793Z","end":"2026-02-18T14:38:19.331388Z","steps":["trace[254183364] 'process raft request' (duration: 1.050527867s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:19.332077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:18.280782Z","time spent":"1.051260159s","remote":"127.0.0.1:54382","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T14:38:19.332464Z","caller":"traceutil/trace.go:171","msg":"trace[712275640] transaction","detail":"{read_only:false; number_of_response:0; response_revision:306; }","duration":"1.058825981s","start":"2026-02-18T14:38:18.273622Z","end":"2026-02-18T14:38:19.332448Z","steps":["trace[712275640] 'process raft request' (duration: 778.273678ms)","trace[712275640] 'compare' (duration: 278.299602ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:19.332646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:18.273602Z","time spent":"1.058978825s","remote":"127.0.0.1:54382","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T14:38:19.333264Z","caller":"traceutil/trace.go:171","msg":"trace[432229842] transaction","detail":"{read_only:false; number_of_response:0; response_revision:306; }","duration":"1.057294232s","start":"2026-02-18T14:38:18.275959Z","end":"2026-02-18T14:38:19.333253Z","steps":["trace[432229842] 'process raft request' (duration: 1.055271008s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:19.333518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:18.275947Z","time spent":"1.057504478s","remote":"127.0.0.1:54368","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T14:38:19.333907Z","caller":"traceutil/trace.go:171","msg":"trace[1915580624] transaction","detail":"{read_only:false; number_of_response:0; response_revision:306; }","duration":"1.055916888s","start":"2026-02-18T14:38:18.277976Z","end":"2026-02-18T14:38:19.333893Z","steps":["trace[1915580624] 'process raft request' (duration: 1.053293555s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:19.334093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:18.277963Z","time spent":"1.056063162s","remote":"127.0.0.1:54382","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T14:38:19.334237Z","caller":"traceutil/trace.go:171","msg":"trace[1532335223] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"749.934461ms","start":"2026-02-18T14:38:18.584016Z","end":"2026-02-18T14:38:19.333951Z","steps":["trace[1532335223] 'process raft request' (duration: 749.88604ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:38:19.334461Z","caller":"traceutil/trace.go:171","msg":"trace[645213396] transaction","detail":"{read_only:false; number_of_response:0; response_revision:306; }","duration":"1.055290247s","start":"2026-02-18T14:38:18.27916Z","end":"2026-02-18T14:38:19.33445Z","steps":["trace[645213396] 'process raft request' (duration: 1.052131718s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:19.334635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:18.584006Z","time spent":"750.317703ms","remote":"127.0.0.1:54252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-18T14:38:19.334657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:18.279151Z","time spent":"1.055474853s","remote":"127.0.0.1:54382","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T14:38:19.335104Z","caller":"traceutil/trace.go:171","msg":"trace[1788794880] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"1.053165479s","start":"2026-02-18T14:38:18.281925Z","end":"2026-02-18T14:38:19.33509Z","steps":["trace[1788794880] 'process raft request' (duration: 1.049415141s)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:38:19.336909Z","caller":"traceutil/trace.go:171","msg":"trace[483540362] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"808.652619ms","start":"2026-02-18T14:38:18.528242Z","end":"2026-02-18T14:38:19.336895Z","steps":["trace[483540362] 'process raft request' (duration: 805.552901ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:19.337663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:18.528219Z","time spent":"809.409522ms","remote":"127.0.0.1:54536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":400,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T14:38:19.337999Z","caller":"traceutil/trace.go:171","msg":"trace[1755984918] linearizableReadLoop","detail":"{readStateIndex:319; appliedIndex:312; }","duration":"813.557914ms","start":"2026-02-18T14:38:18.524428Z","end":"2026-02-18T14:38:19.337986Z","steps":["trace[1755984918] 'read index received' (duration: 56.57286ms)","trace[1755984918] 'applied index is now lower than readState.Index' (duration: 756.983764ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:19.338317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.136253481s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-02-18T14:38:19.338409Z","caller":"traceutil/trace.go:171","msg":"trace[431717490] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:309; }","duration":"1.136362944s","start":"2026-02-18T14:38:18.202038Z","end":"2026-02-18T14:38:19.3384Z","steps":["trace[431717490] 'agreement among raft nodes before linearized reading' (duration: 1.136206149s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:19.338473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:18.202032Z","time spent":"1.136412466s","remote":"127.0.0.1:54568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-02-18T14:38:19.335172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:18.281908Z","time spent":"1.053236071s","remote":"127.0.0.1:54382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3937,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-18T14:38:19.338687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.136957332s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3704"} {"level":"info","ts":"2026-02-18T14:38:19.33876Z","caller":"traceutil/trace.go:171","msg":"trace[1500201729] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:309; }","duration":"1.137049057s","start":"2026-02-18T14:38:18.201704Z","end":"2026-02-18T14:38:19.338753Z","steps":["trace[1500201729] 'agreement among raft nodes before linearized reading' (duration: 1.136938712s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:19.338802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:18.201698Z","time spent":"1.137097458s","remote":"127.0.0.1:54368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3727,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-18T14:38:19.339019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"804.61181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:38:19.339085Z","caller":"traceutil/trace.go:171","msg":"trace[853474117] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:0; response_revision:309; }","duration":"804.699212ms","start":"2026-02-18T14:38:18.534379Z","end":"2026-02-18T14:38:19.339078Z","steps":["trace[853474117] 'agreement among raft nodes before linearized reading' (duration: 804.619299ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:19.339125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:18.534359Z","time spent":"804.759384ms","remote":"127.0.0.1:54390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-02-18T14:38:19.339373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.099105ms","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-18T14:38:19.339445Z","caller":"traceutil/trace.go:171","msg":"trace[940944568] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:309; }","duration":"194.197478ms","start":"2026-02-18T14:38:19.145239Z","end":"2026-02-18T14:38:19.339437Z","steps":["trace[940944568] 'agreement among raft nodes before linearized reading' (duration: 194.108705ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:19.33969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.865682ms","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-18T14:38:19.339768Z","caller":"traceutil/trace.go:171","msg":"trace[1216229167] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:309; }","duration":"245.972175ms","start":"2026-02-18T14:38:19.093789Z","end":"2026-02-18T14:38:19.339761Z","steps":["trace[1216229167] 'agreement among raft nodes before linearized reading' (duration: 245.874612ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:19.339934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.497204ms","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-18T14:38:19.339993Z","caller":"traceutil/trace.go:171","msg":"trace[1848116110] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:309; }","duration":"342.569277ms","start":"2026-02-18T14:38:18.997404Z","end":"2026-02-18T14:38:19.339974Z","steps":["trace[1848116110] 'agreement among raft nodes before linearized reading' (duration: 342.506125ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:19.340091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:18.997391Z","time spent":"342.69139ms","remote":"127.0.0.1:54450","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-18T14:38:19.340269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.519447ms","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-18T14:38:19.340341Z","caller":"traceutil/trace.go:171","msg":"trace[1708756641] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:309; }","duration":"343.641611ms","start":"2026-02-18T14:38:18.996693Z","end":"2026-02-18T14:38:19.340335Z","steps":["trace[1708756641] 'agreement among raft nodes before linearized reading' (duration: 343.528397ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:19.340413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:18.996667Z","time spent":"343.738424ms","remote":"127.0.0.1:54450","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-18T14:38:20.308128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"793.864365ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-18T14:38:20.309121Z","caller":"traceutil/trace.go:171","msg":"trace[347306654] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"949.710794ms","start":"2026-02-18T14:38:19.35938Z","end":"2026-02-18T14:38:20.309091Z","steps":["trace[347306654] 'process raft request' (duration: 949.452946ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:20.309251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:19.359374Z","time spent":"949.816367ms","remote":"127.0.0.1:54390","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":178,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T14:38:20.309469Z","caller":"traceutil/trace.go:171","msg":"trace[906799511] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"950.171248ms","start":"2026-02-18T14:38:19.35928Z","end":"2026-02-18T14:38:20.309452Z","steps":["trace[906799511] 'process raft request' (duration: 154.905161ms)","trace[906799511] 'compare' (duration: 793.626416ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:20.309553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:19.359266Z","time spent":"950.245791ms","remote":"127.0.0.1:54252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T14:38:20.309848Z","caller":"traceutil/trace.go:171","msg":"trace[1469798978] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"370.512351ms","start":"2026-02-18T14:38:19.939315Z","end":"2026-02-18T14:38:20.309828Z","steps":["trace[1469798978] 'process raft request' (duration: 370.441688ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:38:20.309986Z","caller":"traceutil/trace.go:171","msg":"trace[993136576] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"950.391885ms","start":"2026-02-18T14:38:19.359579Z","end":"2026-02-18T14:38:20.309971Z","steps":["trace[993136576] 'process raft request' (duration: 949.530298ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:20.310249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:19.359573Z","time spent":"950.449177ms","remote":"127.0.0.1:54450","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-18T14:38:20.310482Z","caller":"traceutil/trace.go:171","msg":"trace[132570200] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"950.990403ms","start":"2026-02-18T14:38:19.359479Z","end":"2026-02-18T14:38:20.31047Z","steps":["trace[132570200] 'process raft request' (duration: 949.458516ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:20.31055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:19.359457Z","time spent":"951.061296ms","remote":"127.0.0.1:54450","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-18T14:38:20.310667Z","caller":"traceutil/trace.go:171","msg":"trace[2012172405] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"951.129577ms","start":"2026-02-18T14:38:19.359529Z","end":"2026-02-18T14:38:20.310659Z","steps":["trace[2012172405] 'process raft request' (duration: 949.489827ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:38:20.310784Z","caller":"traceutil/trace.go:171","msg":"trace[19483521] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"947.567306ms","start":"2026-02-18T14:38:19.363109Z","end":"2026-02-18T14:38:20.310677Z","steps":["trace[19483521] 'process raft request' (duration: 946.567725ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:20.311093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:19.363101Z","time spent":"947.844955ms","remote":"127.0.0.1:54450","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-18T14:38:20.311653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:19.359522Z","time spent":"951.172589ms","remote":"127.0.0.1:54390","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":164,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T14:38:20.312193Z","caller":"traceutil/trace.go:171","msg":"trace[1304208652] linearizableReadLoop","detail":"{readStateIndex:323; appliedIndex:322; }","duration":"952.598254ms","start":"2026-02-18T14:38:19.359344Z","end":"2026-02-18T14:38:20.311942Z","steps":["trace[1304208652] 'read index received' (duration: 29.483177ms)","trace[1304208652] 'applied index is now lower than readState.Index' (duration: 923.113607ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:20.314865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"955.512074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:38:20.315114Z","caller":"traceutil/trace.go:171","msg":"trace[432493871] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:319; }","duration":"955.750362ms","start":"2026-02-18T14:38:19.359325Z","end":"2026-02-18T14:38:20.315076Z","steps":["trace[432493871] 'agreement among raft nodes before linearized reading' (duration: 955.503544ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:20.315483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:19.35932Z","time spent":"956.157234ms","remote":"127.0.0.1:54154","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-18T14:38:20.315363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"955.885635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6894"} {"level":"info","ts":"2026-02-18T14:38:20.315809Z","caller":"traceutil/trace.go:171","msg":"trace[1568693684] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:319; }","duration":"956.36483ms","start":"2026-02-18T14:38:19.359414Z","end":"2026-02-18T14:38:20.315779Z","steps":["trace[1568693684] 'agreement among raft nodes before linearized reading' (duration: 955.897236ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:20.31594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:19.359411Z","time spent":"956.485064ms","remote":"127.0.0.1:54382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6917,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"info","ts":"2026-02-18T14:38:20.31678Z","caller":"traceutil/trace.go:171","msg":"trace[1016060278] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"957.220318ms","start":"2026-02-18T14:38:19.359548Z","end":"2026-02-18T14:38:20.316768Z","steps":["trace[1016060278] 'process raft request' (duration: 949.525308ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:20.316974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:19.359543Z","time spent":"957.400933ms","remote":"127.0.0.1:54450","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-18T14:38:20.317259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:19.939278Z","time spent":"370.725787ms","remote":"127.0.0.1:54450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T14:38:20.310479Z","caller":"traceutil/trace.go:171","msg":"trace[458314113] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"948.609718ms","start":"2026-02-18T14:38:19.361856Z","end":"2026-02-18T14:38:20.310465Z","steps":["trace[458314113] 'process raft request' (duration: 947.602377ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:20.319955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:19.361828Z","time spent":"958.082723ms","remote":"127.0.0.1:54368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3826,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T14:38:20.821458Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674836838208723,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T14:38:21.791212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"922.514478ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-18T14:38:21.791512Z","caller":"traceutil/trace.go:171","msg":"trace[206422718] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"1.474916117s","start":"2026-02-18T14:38:20.316559Z","end":"2026-02-18T14:38:21.791475Z","steps":["trace[206422718] 'process raft request' (duration: 552.080219ms)","trace[206422718] 'compare' (duration: 922.378504ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:38:21.791575Z","caller":"traceutil/trace.go:171","msg":"trace[1906017287] linearizableReadLoop","detail":"{readStateIndex:334; appliedIndex:331; }","duration":"1.470822869s","start":"2026-02-18T14:38:20.320735Z","end":"2026-02-18T14:38:21.791558Z","steps":["trace[1906017287] 'read index received' (duration: 547.994582ms)","trace[1906017287] 'applied index is now lower than readState.Index' (duration: 922.827357ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:21.7919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:20.316541Z","time spent":"1.475101552s","remote":"127.0.0.1:54252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":636,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T14:38:21.792123Z","caller":"traceutil/trace.go:171","msg":"trace[1871823548] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"1.463681607s","start":"2026-02-18T14:38:20.328429Z","end":"2026-02-18T14:38:21.79211Z","steps":["trace[1871823548] 'process raft request' (duration: 1.462890993s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:21.792278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:20.328412Z","time spent":"1.4637536s","remote":"127.0.0.1:54382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6669,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T14:38:21.792629Z","caller":"traceutil/trace.go:171","msg":"trace[389174745] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"1.463161872s","start":"2026-02-18T14:38:20.329455Z","end":"2026-02-18T14:38:21.792617Z","steps":["trace[389174745] 'process raft request' (duration: 1.462067918s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:21.792779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:20.32945Z","time spent":"1.463213733s","remote":"127.0.0.1:54628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3178,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-18T14:38:21.793026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.472284286s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:38:21.793066Z","caller":"traceutil/trace.go:171","msg":"trace[121636487] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:322; }","duration":"1.472347747s","start":"2026-02-18T14:38:20.320709Z","end":"2026-02-18T14:38:21.793056Z","steps":["trace[121636487] 'agreement among raft nodes before linearized reading' (duration: 1.472284625s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:21.79318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:20.320674Z","time spent":"1.472495691s","remote":"127.0.0.1:54168","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-18T14:38:21.793413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.472556823s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:38:21.793456Z","caller":"traceutil/trace.go:171","msg":"trace[1853883695] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:0; response_revision:322; }","duration":"1.472607245s","start":"2026-02-18T14:38:20.320839Z","end":"2026-02-18T14:38:21.793446Z","steps":["trace[1853883695] 'agreement among raft nodes before linearized reading' (duration: 1.472543653s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:21.793582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:20.320834Z","time spent":"1.472735669s","remote":"127.0.0.1:54390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"warn","ts":"2026-02-18T14:38:21.794077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.921536ms","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-18T14:38:21.794119Z","caller":"traceutil/trace.go:171","msg":"trace[629681084] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:322; }","duration":"402.002349ms","start":"2026-02-18T14:38:21.392107Z","end":"2026-02-18T14:38:21.794109Z","steps":["trace[629681084] 'agreement among raft nodes before linearized reading' (duration: 401.930987ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:21.794251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:21.392086Z","time spent":"402.154514ms","remote":"127.0.0.1:54450","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-18T14:38:22.234619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.847511ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T14:38:22.234756Z","caller":"traceutil/trace.go:171","msg":"trace[1706831271] linearizableReadLoop","detail":"{readStateIndex:335; appliedIndex:334; }","duration":"432.214466ms","start":"2026-02-18T14:38:21.802481Z","end":"2026-02-18T14:38:22.234695Z","steps":["trace[1706831271] 'read index received' (duration: 186.22878ms)","trace[1706831271] 'applied index is now lower than readState.Index' (duration: 245.984656ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:22.234827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.33956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-18T14:38:22.234854Z","caller":"traceutil/trace.go:171","msg":"trace[303769623] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:323; }","duration":"432.377231ms","start":"2026-02-18T14:38:21.802468Z","end":"2026-02-18T14:38:22.234845Z","steps":["trace[303769623] 'agreement among raft nodes before linearized reading' (duration: 432.317339ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:22.23489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:21.802463Z","time spent":"432.414833ms","remote":"127.0.0.1:54296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-02-18T14:38:22.234927Z","caller":"traceutil/trace.go:171","msg":"trace[1923972049] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"432.647559ms","start":"2026-02-18T14:38:21.802253Z","end":"2026-02-18T14:38:22.2349Z","steps":["trace[1923972049] 'process raft request' (duration: 186.443267ms)","trace[1923972049] 'compare' (duration: 245.728928ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:22.235067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:21.802243Z","time spent":"432.751902ms","remote":"127.0.0.1:54450","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-18T14:38:22.249774Z","caller":"traceutil/trace.go:171","msg":"trace[546335132] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"443.22526ms","start":"2026-02-18T14:38:21.806539Z","end":"2026-02-18T14:38:22.249764Z","steps":["trace[546335132] 'process raft request' (duration: 443.188879ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:22.249842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:21.806532Z","time spent":"443.272471ms","remote":"127.0.0.1:54382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4049,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T14:38:22.249833Z","caller":"traceutil/trace.go:171","msg":"trace[97900698] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"446.290574ms","start":"2026-02-18T14:38:21.803515Z","end":"2026-02-18T14:38:22.249805Z","steps":["trace[97900698] 'process raft request' (duration: 446.130669ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:22.249981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:21.803505Z","time spent":"446.390547ms","remote":"127.0.0.1:54222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T14:38:22.753761Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674836838208734,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-18T14:38:23.010694Z","caller":"traceutil/trace.go:171","msg":"trace[442448762] linearizableReadLoop","detail":"{readStateIndex:339; appliedIndex:337; }","duration":"757.592862ms","start":"2026-02-18T14:38:22.253078Z","end":"2026-02-18T14:38:23.01067Z","steps":["trace[442448762] 'read index received' (duration: 661.31637ms)","trace[442448762] 'applied index is now lower than readState.Index' (duration: 96.275452ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:38:23.010851Z","caller":"traceutil/trace.go:171","msg":"trace[593734010] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"771.352229ms","start":"2026-02-18T14:38:22.239484Z","end":"2026-02-18T14:38:23.010836Z","steps":["trace[593734010] 'process raft request' (duration: 674.962453ms)","trace[593734010] 'compare' (duration: 96.016954ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:23.010972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:22.239459Z","time spent":"771.423981ms","remote":"127.0.0.1:54390","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T14:38:23.011251Z","caller":"traceutil/trace.go:171","msg":"trace[1235773508] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"758.092156ms","start":"2026-02-18T14:38:22.253147Z","end":"2026-02-18T14:38:23.011239Z","steps":["trace[1235773508] 'process raft request' (duration: 757.479618ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:23.011296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:22.25314Z","time spent":"758.133687ms","remote":"127.0.0.1:54384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1196,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-18T14:38:23.011487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"758.400206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3952"} {"level":"info","ts":"2026-02-18T14:38:23.011521Z","caller":"traceutil/trace.go:171","msg":"trace[1366690621] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:327; }","duration":"758.457728ms","start":"2026-02-18T14:38:22.253052Z","end":"2026-02-18T14:38:23.01151Z","steps":["trace[1366690621] 'agreement among raft nodes before linearized reading' (duration: 758.360806ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:23.011549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:22.25304Z","time spent":"758.503949ms","remote":"127.0.0.1:54382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":3975,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"warn","ts":"2026-02-18T14:38:23.01231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"686.543434ms","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-18T14:38:23.012372Z","caller":"traceutil/trace.go:171","msg":"trace[2138030563] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:327; }","duration":"686.652357ms","start":"2026-02-18T14:38:22.325708Z","end":"2026-02-18T14:38:23.012361Z","steps":["trace[2138030563] 'agreement among raft nodes before linearized reading' (duration: 686.026198ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:23.012446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:22.325696Z","time spent":"686.74012ms","remote":"127.0.0.1:54450","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-18T14:38:23.012782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.762649ms","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-18T14:38:23.012825Z","caller":"traceutil/trace.go:171","msg":"trace[671975549] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:327; }","duration":"684.828141ms","start":"2026-02-18T14:38:22.327987Z","end":"2026-02-18T14:38:23.012815Z","steps":["trace[671975549] 'agreement among raft nodes before linearized reading' (duration: 684.757849ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:23.012854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:22.327977Z","time spent":"684.870912ms","remote":"127.0.0.1:54450","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-18T14:38:23.012914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.573174ms","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-18T14:38:23.012969Z","caller":"traceutil/trace.go:171","msg":"trace[1212509794] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:327; }","duration":"685.673207ms","start":"2026-02-18T14:38:22.327282Z","end":"2026-02-18T14:38:23.012955Z","steps":["trace[1212509794] 'agreement among raft nodes before linearized reading' (duration: 685.562514ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:23.01301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:22.327263Z","time spent":"685.74165ms","remote":"127.0.0.1:54450","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-18T14:38:23.519546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.927563ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T14:38:23.519868Z","caller":"traceutil/trace.go:171","msg":"trace[1982857691] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"495.286757ms","start":"2026-02-18T14:38:23.024561Z","end":"2026-02-18T14:38:23.519848Z","steps":["trace[1982857691] 'process raft request' (duration: 167.905791ms)","trace[1982857691] 'compare' (duration: 326.808389ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:23.520173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:23.024551Z","time spent":"495.551115ms","remote":"127.0.0.1:54382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5073,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T14:38:23.520656Z","caller":"traceutil/trace.go:171","msg":"trace[14602864] transaction","detail":"{read_only:false; response_revision:331; number_of_response:1; }","duration":"495.192323ms","start":"2026-02-18T14:38:23.02545Z","end":"2026-02-18T14:38:23.520642Z","steps":["trace[14602864] 'process raft request' (duration: 494.741559ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:23.520988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:23.025446Z","time spent":"495.46123ms","remote":"127.0.0.1:54450","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-18T14:38:23.520513Z","caller":"traceutil/trace.go:171","msg":"trace[886145834] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"441.7815ms","start":"2026-02-18T14:38:23.078705Z","end":"2026-02-18T14:38:23.520487Z","steps":["trace[886145834] 'process raft request' (duration: 441.717938ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:23.522231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:23.078687Z","time spent":"443.395808ms","remote":"127.0.0.1:54638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2629,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T14:38:23.521919Z","caller":"traceutil/trace.go:171","msg":"trace[1487858725] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"496.537453ms","start":"2026-02-18T14:38:23.025373Z","end":"2026-02-18T14:38:23.52191Z","steps":["trace[1487858725] 'process raft request' (duration: 494.406879ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:23.522592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:23.025365Z","time spent":"497.158622ms","remote":"127.0.0.1:54450","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-18T14:38:23.522688Z","caller":"traceutil/trace.go:171","msg":"trace[179150939] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"496.951806ms","start":"2026-02-18T14:38:23.025693Z","end":"2026-02-18T14:38:23.522644Z","steps":["trace[179150939] 'process raft request' (duration: 494.650917ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:23.522893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:23.025688Z","time spent":"497.09177ms","remote":"127.0.0.1:54450","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-18T14:38:23.523189Z","caller":"traceutil/trace.go:171","msg":"trace[1831085502] linearizableReadLoop","detail":"{readStateIndex:342; appliedIndex:340; }","duration":"497.75784ms","start":"2026-02-18T14:38:23.025418Z","end":"2026-02-18T14:38:23.523175Z","steps":["trace[1831085502] 'read index received' (duration: 47.600229ms)","trace[1831085502] 'applied index is now lower than readState.Index' (duration: 450.156101ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:23.523385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.957315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:38:23.523482Z","caller":"traceutil/trace.go:171","msg":"trace[2030512818] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:0; response_revision:333; }","duration":"498.017738ms","start":"2026-02-18T14:38:23.025399Z","end":"2026-02-18T14:38:23.523417Z","steps":["trace[2030512818] 'agreement among raft nodes before linearized reading' (duration: 497.826612ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:23.52355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:23.025395Z","time spent":"498.144151ms","remote":"127.0.0.1:54390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"info","ts":"2026-02-18T14:38:23.807835Z","caller":"traceutil/trace.go:171","msg":"trace[970582897] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"243.707675ms","start":"2026-02-18T14:38:23.564107Z","end":"2026-02-18T14:38:23.807814Z","steps":["trace[970582897] 'process raft request' (duration: 243.671604ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:38:23.808052Z","caller":"traceutil/trace.go:171","msg":"trace[1919059808] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"274.421678ms","start":"2026-02-18T14:38:23.533616Z","end":"2026-02-18T14:38:23.808038Z","steps":["trace[1919059808] 'process raft request' (duration: 214.359964ms)","trace[1919059808] 'compare' (duration: 59.151347ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:38:23.808087Z","caller":"traceutil/trace.go:171","msg":"trace[1233907484] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"244.127758ms","start":"2026-02-18T14:38:23.563953Z","end":"2026-02-18T14:38:23.80808Z","steps":["trace[1233907484] 'process raft request' (duration: 243.755167ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:38:24.138986Z","caller":"traceutil/trace.go:171","msg":"trace[1611776054] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"274.111362ms","start":"2026-02-18T14:38:23.86485Z","end":"2026-02-18T14:38:24.138961Z","steps":["trace[1611776054] 'process raft request' (duration: 274.0746ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:38:24.139686Z","caller":"traceutil/trace.go:171","msg":"trace[2130923881] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"321.769062ms","start":"2026-02-18T14:38:23.817899Z","end":"2026-02-18T14:38:24.139668Z","steps":["trace[2130923881] 'process raft request' (duration: 222.563709ms)","trace[2130923881] 'compare' (duration: 97.759831ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:24.139918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:23.817892Z","time spent":"321.918706ms","remote":"127.0.0.1:54382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4579,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T14:38:24.140235Z","caller":"traceutil/trace.go:171","msg":"trace[1242527805] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"275.926605ms","start":"2026-02-18T14:38:23.864293Z","end":"2026-02-18T14:38:24.14022Z","steps":["trace[1242527805] 'process raft request' (duration: 274.556455ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:24.655068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.329282ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T14:38:24.655127Z","caller":"traceutil/trace.go:171","msg":"trace[1814808178] linearizableReadLoop","detail":"{readStateIndex:354; appliedIndex:353; }","duration":"497.285534ms","start":"2026-02-18T14:38:24.157832Z","end":"2026-02-18T14:38:24.655118Z","steps":["trace[1814808178] 'read index received' (duration: 289.792648ms)","trace[1814808178] 'applied index is now lower than readState.Index' (duration: 207.492316ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:38:24.655235Z","caller":"traceutil/trace.go:171","msg":"trace[1459166971] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"498.847422ms","start":"2026-02-18T14:38:24.156382Z","end":"2026-02-18T14:38:24.655229Z","steps":["trace[1459166971] 'process raft request' (duration: 291.309094ms)","trace[1459166971] 'compare' (duration: 207.224328ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:24.655266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:24.156369Z","time spent":"498.880182ms","remote":"127.0.0.1:54382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6669,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T14:38:24.655361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.528832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-18T14:38:24.655374Z","caller":"traceutil/trace.go:171","msg":"trace[1388633357] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:342; }","duration":"497.566013ms","start":"2026-02-18T14:38:24.157804Z","end":"2026-02-18T14:38:24.65537Z","steps":["trace[1388633357] 'agreement among raft nodes before linearized reading' (duration: 497.539272ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:24.655386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:24.15779Z","time spent":"497.593504ms","remote":"127.0.0.1:54296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-02-18T14:38:24.65545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.003203ms","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-18T14:38:24.655462Z","caller":"traceutil/trace.go:171","msg":"trace[1887426283] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:342; }","duration":"416.049674ms","start":"2026-02-18T14:38:24.239409Z","end":"2026-02-18T14:38:24.655459Z","steps":["trace[1887426283] 'agreement among raft nodes before linearized reading' (duration: 416.027274ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:24.655475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:24.239395Z","time spent":"416.077285ms","remote":"127.0.0.1:54450","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-18T14:38:39.868526Z","caller":"traceutil/trace.go:171","msg":"trace[1126908993] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"157.273449ms","start":"2026-02-18T14:38:39.711226Z","end":"2026-02-18T14:38:39.8685Z","steps":["trace[1126908993] 'process raft request' (duration: 116.33961ms)","trace[1126908993] 'compare' (duration: 40.859467ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:38:41.177482Z","caller":"traceutil/trace.go:171","msg":"trace[1590134109] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"321.81491ms","start":"2026-02-18T14:38:40.855644Z","end":"2026-02-18T14:38:41.177459Z","steps":["trace[1590134109] 'process raft request' (duration: 321.690727ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:41.177706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:40.855617Z","time spent":"322.006785ms","remote":"127.0.0.1:54450","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-18T14:38:41.272759Z","caller":"traceutil/trace.go:171","msg":"trace[422779896] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"322.568383ms","start":"2026-02-18T14:38:40.950161Z","end":"2026-02-18T14:38:41.272729Z","steps":["trace[422779896] 'process raft request' (duration: 301.380993ms)","trace[422779896] 'compare' (duration: 20.145845ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:38:41.273011Z","caller":"traceutil/trace.go:171","msg":"trace[2013070500] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"244.659583ms","start":"2026-02-18T14:38:41.028317Z","end":"2026-02-18T14:38:41.272976Z","steps":["trace[2013070500] 'process raft request' (duration: 244.329895ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:41.273143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:40.950135Z","time spent":"322.785179ms","remote":"127.0.0.1:54450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T14:38:47.119525Z","caller":"traceutil/trace.go:171","msg":"trace[1447840446] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"387.405417ms","start":"2026-02-18T14:38:46.732095Z","end":"2026-02-18T14:38:47.1195Z","steps":["trace[1447840446] 'process raft request' (duration: 387.056219ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:47.119677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:46.732053Z","time spent":"387.53818ms","remote":"127.0.0.1:54280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317276,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T14:38:47.300583Z","caller":"traceutil/trace.go:171","msg":"trace[1027903089] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"151.495487ms","start":"2026-02-18T14:38:47.149067Z","end":"2026-02-18T14:38:47.300562Z","steps":["trace[1027903089] 'process raft request' (duration: 91.035981ms)","trace[1027903089] 'compare' (duration: 59.927094ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:38:47.30178Z","caller":"traceutil/trace.go:171","msg":"trace[2034575346] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"152.549421ms","start":"2026-02-18T14:38:47.149216Z","end":"2026-02-18T14:38:47.301765Z","steps":["trace[2034575346] 'process raft request' (duration: 150.960405ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:47.638447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.616232ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T14:38:47.638848Z","caller":"traceutil/trace.go:171","msg":"trace[710636510] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"328.80993ms","start":"2026-02-18T14:38:47.309718Z","end":"2026-02-18T14:38:47.638528Z","steps":["trace[710636510] 'process raft request' (duration: 118.038014ms)","trace[710636510] 'compare' (duration: 210.480758ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:47.639258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:47.309711Z","time spent":"329.187948ms","remote":"127.0.0.1:54450","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-18T14:38:47.70903Z","caller":"traceutil/trace.go:171","msg":"trace[1433126204] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"317.247553ms","start":"2026-02-18T14:38:47.391762Z","end":"2026-02-18T14:38:47.709009Z","steps":["trace[1433126204] 'process raft request' (duration: 317.205862ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:47.709327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:47.39175Z","time spent":"317.488379ms","remote":"127.0.0.1:54522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2364,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T14:38:47.709544Z","caller":"traceutil/trace.go:171","msg":"trace[1974833409] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"317.863137ms","start":"2026-02-18T14:38:47.391667Z","end":"2026-02-18T14:38:47.70953Z","steps":["trace[1974833409] 'process raft request' (duration: 317.194372ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:47.709695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:47.391647Z","time spent":"318.01314ms","remote":"127.0.0.1:54522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1639,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-18T14:38:48.031096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.009752ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-18T14:38:48.031379Z","caller":"traceutil/trace.go:171","msg":"trace[775630813] linearizableReadLoop","detail":"{readStateIndex:526; appliedIndex:525; }","duration":"300.542231ms","start":"2026-02-18T14:38:47.730744Z","end":"2026-02-18T14:38:48.031287Z","steps":["trace[775630813] 'read index received' (duration: 1.457265ms)","trace[775630813] 'applied index is now lower than readState.Index' (duration: 299.083676ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:38:48.031649Z","caller":"traceutil/trace.go:171","msg":"trace[1406132426] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"316.422927ms","start":"2026-02-18T14:38:47.715066Z","end":"2026-02-18T14:38:48.031489Z","steps":["trace[1406132426] 'process raft request' (duration: 79.931364ms)","trace[1406132426] 'compare' (duration: 235.828878ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:48.031859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.079413ms","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-18T14:38:48.032091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:47.71505Z","time spent":"316.668562ms","remote":"127.0.0.1:54536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":734,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T14:38:48.03211Z","caller":"traceutil/trace.go:171","msg":"trace[1700007902] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:506; }","duration":"301.331429ms","start":"2026-02-18T14:38:47.730739Z","end":"2026-02-18T14:38:48.03207Z","steps":["trace[1700007902] 'agreement among raft nodes before linearized reading' (duration: 300.914219ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:48.032386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:47.73068Z","time spent":"301.666546ms","remote":"127.0.0.1:54450","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-18T14:38:48.032968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.096544ms","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-18T14:38:48.033022Z","caller":"traceutil/trace.go:171","msg":"trace[474996722] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:506; }","duration":"279.174086ms","start":"2026-02-18T14:38:47.753835Z","end":"2026-02-18T14:38:48.033009Z","steps":["trace[474996722] 'agreement among raft nodes before linearized reading' (duration: 279.066184ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:48.035074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.736229ms","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-18T14:38:48.03512Z","caller":"traceutil/trace.go:171","msg":"trace[1359292784] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:506; }","duration":"136.8281ms","start":"2026-02-18T14:38:47.898281Z","end":"2026-02-18T14:38:48.035109Z","steps":["trace[1359292784] 'agreement among raft nodes before linearized reading' (duration: 136.736668ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:38:48.250056Z","caller":"traceutil/trace.go:171","msg":"trace[1835436546] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"210.453288ms","start":"2026-02-18T14:38:48.039574Z","end":"2026-02-18T14:38:48.250028Z","steps":["trace[1835436546] 'process raft request' (duration: 142.223219ms)","trace[1835436546] 'compare' (duration: 68.061075ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:38:48.250642Z","caller":"traceutil/trace.go:171","msg":"trace[850477441] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"208.176816ms","start":"2026-02-18T14:38:48.04244Z","end":"2026-02-18T14:38:48.250617Z","steps":["trace[850477441] 'process raft request' (duration: 207.538982ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:38:48.2521Z","caller":"traceutil/trace.go:171","msg":"trace[1303265271] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"209.162849ms","start":"2026-02-18T14:38:48.04292Z","end":"2026-02-18T14:38:48.252083Z","steps":["trace[1303265271] 'process raft request' (duration: 207.598303ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:38:48.252556Z","caller":"traceutil/trace.go:171","msg":"trace[1769440036] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"162.568914ms","start":"2026-02-18T14:38:48.089976Z","end":"2026-02-18T14:38:48.252545Z","steps":["trace[1769440036] 'process raft request' (duration: 161.608242ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:38:48.520826Z","caller":"traceutil/trace.go:171","msg":"trace[1442437795] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"167.60454ms","start":"2026-02-18T14:38:48.353199Z","end":"2026-02-18T14:38:48.520803Z","steps":["trace[1442437795] 'process raft request' (duration: 167.450285ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:38:48.683194Z","caller":"traceutil/trace.go:171","msg":"trace[243617697] linearizableReadLoop","detail":"{readStateIndex:534; appliedIndex:532; }","duration":"324.946254ms","start":"2026-02-18T14:38:48.35823Z","end":"2026-02-18T14:38:48.683176Z","steps":["trace[243617697] 'read index received' (duration: 162.547365ms)","trace[243617697] 'applied index is now lower than readState.Index' (duration: 162.398199ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:38:48.683454Z","caller":"traceutil/trace.go:171","msg":"trace[1860260979] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"325.474187ms","start":"2026-02-18T14:38:48.357959Z","end":"2026-02-18T14:38:48.683433Z","steps":["trace[1860260979] 'process raft request' (duration: 248.844576ms)","trace[1860260979] 'compare' (duration: 76.287792ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:48.683632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.382245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:38:48.684646Z","caller":"traceutil/trace.go:171","msg":"trace[1445543980] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:514; }","duration":"326.417488ms","start":"2026-02-18T14:38:48.358211Z","end":"2026-02-18T14:38:48.684628Z","steps":["trace[1445543980] 'agreement among raft nodes before linearized reading' (duration: 325.294573ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:48.684703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:48.358204Z","time spent":"326.485489ms","remote":"127.0.0.1:54154","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-18T14:38:48.683949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.54846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:38:48.684949Z","caller":"traceutil/trace.go:171","msg":"trace[1057183664] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:514; }","duration":"155.576234ms","start":"2026-02-18T14:38:48.529359Z","end":"2026-02-18T14:38:48.684936Z","steps":["trace[1057183664] 'agreement among raft nodes before linearized reading' (duration: 154.545931ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:48.685555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:48.35795Z","time spent":"326.114001ms","remote":"127.0.0.1:54628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3805,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T14:38:48.924432Z","caller":"traceutil/trace.go:171","msg":"trace[1909684287] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"232.964583ms","start":"2026-02-18T14:38:48.691447Z","end":"2026-02-18T14:38:48.924411Z","steps":["trace[1909684287] 'process raft request' (duration: 221.466779ms)","trace[1909684287] 'compare' (duration: 11.397202ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:38:48.971259Z","caller":"traceutil/trace.go:171","msg":"trace[427639178] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"211.793158ms","start":"2026-02-18T14:38:48.759444Z","end":"2026-02-18T14:38:48.971237Z","steps":["trace[427639178] 'process raft request' (duration: 211.621864ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:38:48.971766Z","caller":"traceutil/trace.go:171","msg":"trace[699594827] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"276.804373ms","start":"2026-02-18T14:38:48.694936Z","end":"2026-02-18T14:38:48.97174Z","steps":["trace[699594827] 'process raft request' (duration: 275.919333ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:38:49.322343Z","caller":"traceutil/trace.go:171","msg":"trace[919578193] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"209.348245ms","start":"2026-02-18T14:38:49.112948Z","end":"2026-02-18T14:38:49.322296Z","steps":["trace[919578193] 'process raft request' (duration: 162.657969ms)","trace[919578193] 'compare' (duration: 46.459951ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:38:49.32241Z","caller":"traceutil/trace.go:171","msg":"trace[127093219] linearizableReadLoop","detail":"{readStateIndex:550; appliedIndex:548; }","duration":"168.49032ms","start":"2026-02-18T14:38:49.153869Z","end":"2026-02-18T14:38:49.322359Z","steps":["trace[127093219] 'read index received' (duration: 121.744123ms)","trace[127093219] 'applied index is now lower than readState.Index' (duration: 46.744307ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:38:49.322655Z","caller":"traceutil/trace.go:171","msg":"trace[1314620706] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"209.585999ms","start":"2026-02-18T14:38:49.113047Z","end":"2026-02-18T14:38:49.322633Z","steps":["trace[1314620706] 'process raft request' (duration: 209.18718ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:49.322837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.269848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/cilium\" ","response":"range_response_count:1 size:14309"} {"level":"info","ts":"2026-02-18T14:38:49.322862Z","caller":"traceutil/trace.go:171","msg":"trace[1946473378] range","detail":"{range_begin:/registry/daemonsets/kube-system/cilium; range_end:; response_count:1; response_revision:530; }","duration":"215.332419ms","start":"2026-02-18T14:38:49.107522Z","end":"2026-02-18T14:38:49.322855Z","steps":["trace[1946473378] 'agreement among raft nodes before linearized reading' (duration: 215.225957ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:38:49.415946Z","caller":"traceutil/trace.go:171","msg":"trace[567153307] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"255.478968ms","start":"2026-02-18T14:38:49.160116Z","end":"2026-02-18T14:38:49.415595Z","steps":["trace[567153307] 'process raft request' (duration: 255.297134ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:49.417207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.166462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"} {"level":"info","ts":"2026-02-18T14:38:49.417486Z","caller":"traceutil/trace.go:171","msg":"trace[704231419] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:531; }","duration":"133.48903ms","start":"2026-02-18T14:38:49.283976Z","end":"2026-02-18T14:38:49.417465Z","steps":["trace[704231419] 'agreement among raft nodes before linearized reading' (duration: 131.939134ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:49.41879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.678856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"} {"level":"info","ts":"2026-02-18T14:38:49.419548Z","caller":"traceutil/trace.go:171","msg":"trace[1641053121] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:531; }","duration":"135.413263ms","start":"2026-02-18T14:38:49.284083Z","end":"2026-02-18T14:38:49.419496Z","steps":["trace[1641053121] 'agreement among raft nodes before linearized reading' (duration: 131.534985ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:49.435338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.746893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329932"} {"level":"info","ts":"2026-02-18T14:38:49.43538Z","caller":"traceutil/trace.go:171","msg":"trace[1948024498] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:531; }","duration":"224.910486ms","start":"2026-02-18T14:38:49.21046Z","end":"2026-02-18T14:38:49.43537Z","steps":["trace[1948024498] 'agreement among raft nodes before linearized reading' (duration: 209.688872ms)","trace[1948024498] 'range keys from bolt db' (duration: 14.877656ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:49.507278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.807111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/cilium\" ","response":"range_response_count:1 size:14309"} {"level":"info","ts":"2026-02-18T14:38:49.507332Z","caller":"traceutil/trace.go:171","msg":"trace[1258377340] range","detail":"{range_begin:/registry/daemonsets/kube-system/cilium; range_end:; response_count:1; response_revision:531; }","duration":"173.889632ms","start":"2026-02-18T14:38:49.333427Z","end":"2026-02-18T14:38:49.507317Z","steps":["trace[1258377340] 'agreement among raft nodes before linearized reading' (duration: 93.829431ms)","trace[1258377340] 'range keys from in-memory index tree' (duration: 79.958828ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:49.507451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.713834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-gql96\" ","response":"range_response_count:1 size:3615"} {"level":"info","ts":"2026-02-18T14:38:49.507469Z","caller":"traceutil/trace.go:171","msg":"trace[1429458247] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-gql96; range_end:; response_count:1; response_revision:531; }","duration":"179.755525ms","start":"2026-02-18T14:38:49.327707Z","end":"2026-02-18T14:38:49.507463Z","steps":["trace[1429458247] 'agreement among raft nodes before linearized reading' (duration: 99.531751ms)","trace[1429458247] 'range keys from in-memory index tree' (duration: 80.169603ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:38:50.70099Z","caller":"traceutil/trace.go:171","msg":"trace[253816222] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"438.646599ms","start":"2026-02-18T14:38:50.262326Z","end":"2026-02-18T14:38:50.700972Z","steps":["trace[253816222] 'process raft request' (duration: 438.538807ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:50.70111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:50.262313Z","time spent":"438.744152ms","remote":"127.0.0.1:54450","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-18T14:38:51.644352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.392585ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T14:38:51.645308Z","caller":"traceutil/trace.go:171","msg":"trace[1519882640] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"1.382377541s","start":"2026-02-18T14:38:50.262906Z","end":"2026-02-18T14:38:51.645283Z","steps":["trace[1519882640] 'process raft request' (duration: 1.021975464s)","trace[1519882640] 'compare' (duration: 359.066317ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:51.645397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:50.262895Z","time spent":"1.382457824s","remote":"127.0.0.1:54450","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-18T14:38:51.646078Z","caller":"traceutil/trace.go:171","msg":"trace[745467133] linearizableReadLoop","detail":"{readStateIndex:557; appliedIndex:555; }","duration":"1.292420227s","start":"2026-02-18T14:38:50.353641Z","end":"2026-02-18T14:38:51.646061Z","steps":["trace[745467133] 'read index received' (duration: 347.337645ms)","trace[745467133] 'applied index is now lower than readState.Index' (duration: 945.080522ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:38:51.646268Z","caller":"traceutil/trace.go:171","msg":"trace[2099281519] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"1.381080062s","start":"2026-02-18T14:38:50.265151Z","end":"2026-02-18T14:38:51.646231Z","steps":["trace[2099281519] 'process raft request' (duration: 1.379284823s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:51.646396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:50.26514Z","time spent":"1.381164513s","remote":"127.0.0.1:54450","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-18T14:38:51.645807Z","caller":"traceutil/trace.go:171","msg":"trace[2093761838] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"1.031645369s","start":"2026-02-18T14:38:50.614147Z","end":"2026-02-18T14:38:51.645792Z","steps":["trace[2093761838] 'process raft request' (duration: 1.030342041s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:51.647618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:50.614131Z","time spent":"1.033292296s","remote":"127.0.0.1:54252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":766,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-18T14:38:51.652299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.298652995s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:38:51.652335Z","caller":"traceutil/trace.go:171","msg":"trace[616549648] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:538; }","duration":"1.298714377s","start":"2026-02-18T14:38:50.353611Z","end":"2026-02-18T14:38:51.652325Z","steps":["trace[616549648] 'agreement among raft nodes before linearized reading' (duration: 1.292600001s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:51.652411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:50.353596Z","time spent":"1.298807638s","remote":"127.0.0.1:54154","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-18T14:38:51.65251Z","caller":"traceutil/trace.go:171","msg":"trace[1994003912] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"323.945999ms","start":"2026-02-18T14:38:51.328556Z","end":"2026-02-18T14:38:51.652503Z","steps":["trace[1994003912] 'process raft request' (duration: 323.613041ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:51.652581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:51.328536Z","time spent":"323.994849ms","remote":"127.0.0.1:54450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T14:38:51.652952Z","caller":"traceutil/trace.go:171","msg":"trace[97381972] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"261.059456ms","start":"2026-02-18T14:38:51.391839Z","end":"2026-02-18T14:38:51.652898Z","steps":["trace[97381972] 'process raft request' (duration: 260.630196ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:51.653232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.385575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4018"} {"level":"info","ts":"2026-02-18T14:38:51.653259Z","caller":"traceutil/trace.go:171","msg":"trace[1175516640] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:540; }","duration":"364.437967ms","start":"2026-02-18T14:38:51.288815Z","end":"2026-02-18T14:38:51.653253Z","steps":["trace[1175516640] 'agreement among raft nodes before linearized reading' (duration: 364.389776ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:51.653306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:51.288801Z","time spent":"364.499418ms","remote":"127.0.0.1:54368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4041,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-18T14:38:54.177073Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674836838209182,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-18T14:38:54.206743Z","caller":"traceutil/trace.go:171","msg":"trace[482452069] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"551.838623ms","start":"2026-02-18T14:38:53.654853Z","end":"2026-02-18T14:38:54.206692Z","steps":["trace[482452069] 'process raft request' (duration: 551.714171ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:54.206863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:53.654832Z","time spent":"551.959185ms","remote":"127.0.0.1:54450","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-18T14:38:54.275753Z","caller":"traceutil/trace.go:171","msg":"trace[97528783] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:566; }","duration":"600.565578ms","start":"2026-02-18T14:38:53.67517Z","end":"2026-02-18T14:38:54.275735Z","steps":["trace[97528783] 'read index received' (duration: 531.40116ms)","trace[97528783] 'applied index is now lower than readState.Index' (duration: 69.163778ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:54.275899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.714501ms","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-18T14:38:54.275918Z","caller":"traceutil/trace.go:171","msg":"trace[726015482] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:547; }","duration":"600.788682ms","start":"2026-02-18T14:38:53.675124Z","end":"2026-02-18T14:38:54.275912Z","steps":["trace[726015482] 'agreement among raft nodes before linearized reading' (duration: 600.67838ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:54.275937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:53.675109Z","time spent":"600.824423ms","remote":"127.0.0.1:54450","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-18T14:38:54.276007Z","caller":"traceutil/trace.go:171","msg":"trace[1170941871] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"619.60737ms","start":"2026-02-18T14:38:53.656395Z","end":"2026-02-18T14:38:54.276002Z","steps":["trace[1170941871] 'process raft request' (duration: 619.259863ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:54.27605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:53.656385Z","time spent":"619.632741ms","remote":"127.0.0.1:54450","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-18T14:38:54.668868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.640434ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T14:38:54.668976Z","caller":"traceutil/trace.go:171","msg":"trace[354629828] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:568; }","duration":"360.162355ms","start":"2026-02-18T14:38:54.308795Z","end":"2026-02-18T14:38:54.668957Z","steps":["trace[354629828] 'read index received' (duration: 311.686µs)","trace[354629828] 'applied index is now lower than readState.Index' (duration: 359.849039ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:38:54.669059Z","caller":"traceutil/trace.go:171","msg":"trace[276436568] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"388.527115ms","start":"2026-02-18T14:38:54.28052Z","end":"2026-02-18T14:38:54.669047Z","steps":["trace[276436568] 'process raft request' (duration: 28.621845ms)","trace[276436568] 'compare' (duration: 359.43762ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:38:54.669142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:54.280504Z","time spent":"388.605437ms","remote":"127.0.0.1:54450","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-18T14:38:54.669285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.488872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:38:54.669318Z","caller":"traceutil/trace.go:171","msg":"trace[585695734] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:548; }","duration":"360.521512ms","start":"2026-02-18T14:38:54.308785Z","end":"2026-02-18T14:38:54.669307Z","steps":["trace[585695734] 'agreement among raft nodes before linearized reading' (duration: 360.466581ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:54.669348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:54.308745Z","time spent":"360.596194ms","remote":"127.0.0.1:54280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "} {"level":"warn","ts":"2026-02-18T14:38:54.669511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.451166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:38:54.669541Z","caller":"traceutil/trace.go:171","msg":"trace[1018877909] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:548; }","duration":"316.479786ms","start":"2026-02-18T14:38:54.353053Z","end":"2026-02-18T14:38:54.669532Z","steps":["trace[1018877909] 'agreement among raft nodes before linearized reading' (duration: 316.436875ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:38:54.669571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:38:54.353036Z","time spent":"316.529828ms","remote":"127.0.0.1:54154","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-18T14:39:01.480988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.148868ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-18T14:39:01.481089Z","caller":"traceutil/trace.go:171","msg":"trace[1194824298] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"151.733679ms","start":"2026-02-18T14:39:01.329335Z","end":"2026-02-18T14:39:01.481069Z","steps":["trace[1194824298] 'read index received' (duration: 26.72µs)","trace[1194824298] 'applied index is now lower than readState.Index' (duration: 151.705219ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:39:01.481415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.028972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-18T14:39:01.481442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.096566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ttnwq\" ","response":"range_response_count:1 size:16652"} {"level":"info","ts":"2026-02-18T14:39:01.481459Z","caller":"traceutil/trace.go:171","msg":"trace[1841424012] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:587; }","duration":"124.091243ms","start":"2026-02-18T14:39:01.357355Z","end":"2026-02-18T14:39:01.481446Z","steps":["trace[1841424012] 'agreement among raft nodes before linearized reading' (duration: 124.019092ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:01.481478Z","caller":"traceutil/trace.go:171","msg":"trace[2047001248] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ttnwq; range_end:; response_count:1; response_revision:587; }","duration":"152.157537ms","start":"2026-02-18T14:39:01.329308Z","end":"2026-02-18T14:39:01.481466Z","steps":["trace[2047001248] 'agreement among raft nodes before linearized reading' (duration: 152.000064ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:01.834349Z","caller":"traceutil/trace.go:171","msg":"trace[352686781] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"342.971102ms","start":"2026-02-18T14:39:01.491362Z","end":"2026-02-18T14:39:01.834333Z","steps":["trace[352686781] 'process raft request' (duration: 342.835409ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:01.834444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:01.491351Z","time spent":"343.042893ms","remote":"127.0.0.1:54382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T14:39:01.849047Z","caller":"traceutil/trace.go:171","msg":"trace[1262234703] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"146.920772ms","start":"2026-02-18T14:39:01.702107Z","end":"2026-02-18T14:39:01.849028Z","steps":["trace[1262234703] 'process raft request' (duration: 146.802639ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:02.731589Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674836838209277,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T14:39:03.232107Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674836838209277,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T14:39:03.368926Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.322719033s","expected-duration":"1s"} {"level":"info","ts":"2026-02-18T14:39:03.369193Z","caller":"traceutil/trace.go:171","msg":"trace[1969433375] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"1.13770934s","start":"2026-02-18T14:39:02.231467Z","end":"2026-02-18T14:39:03.369177Z","steps":["trace[1969433375] 'read index received' (duration: 1.137622678s)","trace[1969433375] 'applied index is now lower than readState.Index' (duration: 86.112µs)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:39:03.36946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.05736708s","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-18T14:39:03.36945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.137971155s","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-18T14:39:03.369479Z","caller":"traceutil/trace.go:171","msg":"trace[591848508] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:590; }","duration":"1.057430751s","start":"2026-02-18T14:39:02.312043Z","end":"2026-02-18T14:39:03.369474Z","steps":["trace[591848508] 'agreement among raft nodes before linearized reading' (duration: 1.057341909s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:03.369497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:02.312024Z","time spent":"1.057469552s","remote":"127.0.0.1:54450","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":"info","ts":"2026-02-18T14:39:03.369497Z","caller":"traceutil/trace.go:171","msg":"trace[1534557004] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:590; }","duration":"1.138064887s","start":"2026-02-18T14:39:02.231417Z","end":"2026-02-18T14:39:03.369482Z","steps":["trace[1534557004] 'agreement among raft nodes before linearized reading' (duration: 1.137878123s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:03.369537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:02.231377Z","time spent":"1.138152808s","remote":"127.0.0.1:54450","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-18T14:39:03.369645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.485097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:39:03.36966Z","caller":"traceutil/trace.go:171","msg":"trace[999660466] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:590; }","duration":"152.523957ms","start":"2026-02-18T14:39:03.217131Z","end":"2026-02-18T14:39:03.369655Z","steps":["trace[999660466] 'agreement among raft nodes before linearized reading' (duration: 152.503277ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:03.369742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.118956ms","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-18T14:39:03.369736Z","caller":"traceutil/trace.go:171","msg":"trace[735702748] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"1.32359354s","start":"2026-02-18T14:39:02.046128Z","end":"2026-02-18T14:39:03.369722Z","steps":["trace[735702748] 'process raft request' (duration: 1.322961527s)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:03.369755Z","caller":"traceutil/trace.go:171","msg":"trace[559674259] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:590; }","duration":"620.149826ms","start":"2026-02-18T14:39:02.749601Z","end":"2026-02-18T14:39:03.36975Z","steps":["trace[559674259] 'agreement among raft nodes before linearized reading' (duration: 620.112175ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:03.369768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:02.74959Z","time spent":"620.175736ms","remote":"127.0.0.1:54450","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-18T14:39:03.369845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.378019ms","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-18T14:39:03.369858Z","caller":"traceutil/trace.go:171","msg":"trace[1406765146] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:590; }","duration":"639.42482ms","start":"2026-02-18T14:39:02.730429Z","end":"2026-02-18T14:39:03.369854Z","steps":["trace[1406765146] 'agreement among raft nodes before linearized reading' (duration: 639.38961ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:03.369869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:02.730411Z","time spent":"639.45542ms","remote":"127.0.0.1:54450","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-18T14:39:03.369904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:02.046112Z","time spent":"1.323655211s","remote":"127.0.0.1:54450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T14:39:05.949214Z","caller":"traceutil/trace.go:171","msg":"trace[279645492] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"382.210629ms","start":"2026-02-18T14:39:05.566985Z","end":"2026-02-18T14:39:05.949196Z","steps":["trace[279645492] 'process raft request' (duration: 382.025925ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:05.94946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:05.566971Z","time spent":"382.394033ms","remote":"127.0.0.1:54382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4609,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T14:39:05.95245Z","caller":"traceutil/trace.go:171","msg":"trace[1362952769] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:646; }","duration":"349.046127ms","start":"2026-02-18T14:39:05.603392Z","end":"2026-02-18T14:39:05.952439Z","steps":["trace[1362952769] 'read index received' (duration: 346.477177ms)","trace[1362952769] 'applied index is now lower than readState.Index' (duration: 2.5684ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:39:05.952601Z","caller":"traceutil/trace.go:171","msg":"trace[1522605458] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"384.597134ms","start":"2026-02-18T14:39:05.567998Z","end":"2026-02-18T14:39:05.952595Z","steps":["trace[1522605458] 'process raft request' (duration: 384.339299ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:05.952659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:05.567991Z","time spent":"384.626884ms","remote":"127.0.0.1:54212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4156,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T14:39:05.952769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.79644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:39:05.952802Z","caller":"traceutil/trace.go:171","msg":"trace[1357702428] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:625; }","duration":"226.862181ms","start":"2026-02-18T14:39:05.72593Z","end":"2026-02-18T14:39:05.952792Z","steps":["trace[1357702428] 'agreement among raft nodes before linearized reading' (duration: 226.81236ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:05.952893Z","caller":"traceutil/trace.go:171","msg":"trace[1160229487] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"380.536666ms","start":"2026-02-18T14:39:05.572351Z","end":"2026-02-18T14:39:05.952887Z","steps":["trace[1160229487] 'process raft request' (duration: 380.046286ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:05.95292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:05.572345Z","time spent":"380.559746ms","remote":"127.0.0.1:54212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4068,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T14:39:05.952926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.531576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:39:05.952946Z","caller":"traceutil/trace.go:171","msg":"trace[1116821056] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:625; }","duration":"349.577226ms","start":"2026-02-18T14:39:05.603362Z","end":"2026-02-18T14:39:05.952939Z","steps":["trace[1116821056] 'agreement among raft nodes before linearized reading' (duration: 349.549576ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:05.952966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:05.603348Z","time spent":"349.613287ms","remote":"127.0.0.1:54212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"warn","ts":"2026-02-18T14:39:05.953057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.618446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.62\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-18T14:39:05.953071Z","caller":"traceutil/trace.go:171","msg":"trace[525377035] range","detail":"{range_begin:/registry/masterleases/162.253.55.62; range_end:; response_count:1; response_revision:625; }","duration":"149.632616ms","start":"2026-02-18T14:39:05.803434Z","end":"2026-02-18T14:39:05.953067Z","steps":["trace[525377035] 'agreement among raft nodes before linearized reading' (duration: 149.572395ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:07.2595Z","caller":"traceutil/trace.go:171","msg":"trace[2022001049] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"128.730326ms","start":"2026-02-18T14:39:07.130755Z","end":"2026-02-18T14:39:07.259485Z","steps":["trace[2022001049] 'process raft request' (duration: 128.635574ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:07.403093Z","caller":"traceutil/trace.go:171","msg":"trace[1448318466] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"136.839951ms","start":"2026-02-18T14:39:07.266228Z","end":"2026-02-18T14:39:07.403068Z","steps":["trace[1448318466] 'process raft request' (duration: 136.467394ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:08.667527Z","caller":"traceutil/trace.go:171","msg":"trace[1438086809] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"113.870193ms","start":"2026-02-18T14:39:08.553641Z","end":"2026-02-18T14:39:08.667511Z","steps":["trace[1438086809] 'process raft request' (duration: 113.642699ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:10.551695Z","caller":"traceutil/trace.go:171","msg":"trace[284715667] linearizableReadLoop","detail":"{readStateIndex:704; appliedIndex:703; }","duration":"170.28586ms","start":"2026-02-18T14:39:10.381391Z","end":"2026-02-18T14:39:10.551677Z","steps":["trace[284715667] 'read index received' (duration: 21.07204ms)","trace[284715667] 'applied index is now lower than readState.Index' (duration: 149.21304ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:39:10.552094Z","caller":"traceutil/trace.go:171","msg":"trace[478855415] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"182.379603ms","start":"2026-02-18T14:39:10.369708Z","end":"2026-02-18T14:39:10.552087Z","steps":["trace[478855415] 'process raft request' (duration: 174.68013ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:10.552314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.907391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:39:10.552389Z","caller":"traceutil/trace.go:171","msg":"trace[164939469] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:679; }","duration":"170.991263ms","start":"2026-02-18T14:39:10.381356Z","end":"2026-02-18T14:39:10.552348Z","steps":["trace[164939469] 'agreement among raft nodes before linearized reading' (duration: 170.906311ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:10.556547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.882135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:39:10.556598Z","caller":"traceutil/trace.go:171","msg":"trace[623234008] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:679; }","duration":"174.958977ms","start":"2026-02-18T14:39:10.381633Z","end":"2026-02-18T14:39:10.556592Z","steps":["trace[623234008] 'agreement among raft nodes before linearized reading' (duration: 174.884545ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:10.55715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.119458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:39:10.557367Z","caller":"traceutil/trace.go:171","msg":"trace[338249197] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:679; }","duration":"156.24026ms","start":"2026-02-18T14:39:10.400998Z","end":"2026-02-18T14:39:10.557238Z","steps":["trace[338249197] 'agreement among raft nodes before linearized reading' (duration: 156.136758ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:10.55762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.644397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:39:10.557689Z","caller":"traceutil/trace.go:171","msg":"trace[1684076494] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:679; }","duration":"156.727658ms","start":"2026-02-18T14:39:10.400955Z","end":"2026-02-18T14:39:10.557683Z","steps":["trace[1684076494] 'agreement among raft nodes before linearized reading' (duration: 156.641387ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:10.558161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.205907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:39:10.558246Z","caller":"traceutil/trace.go:171","msg":"trace[1946582492] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:679; }","duration":"171.316078ms","start":"2026-02-18T14:39:10.386923Z","end":"2026-02-18T14:39:10.558239Z","steps":["trace[1946582492] 'agreement among raft nodes before linearized reading' (duration: 171.197066ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:10.558534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.577294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:39:10.558584Z","caller":"traceutil/trace.go:171","msg":"trace[60906743] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:679; }","duration":"157.652876ms","start":"2026-02-18T14:39:10.400921Z","end":"2026-02-18T14:39:10.558574Z","steps":["trace[60906743] 'agreement among raft nodes before linearized reading' (duration: 157.564274ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:10.558877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.37104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ttnwq\" ","response":"range_response_count:1 size:18071"} {"level":"info","ts":"2026-02-18T14:39:10.558897Z","caller":"traceutil/trace.go:171","msg":"trace[1101435030] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ttnwq; range_end:; response_count:1; response_revision:679; }","duration":"171.40525ms","start":"2026-02-18T14:39:10.387487Z","end":"2026-02-18T14:39:10.558892Z","steps":["trace[1101435030] 'agreement among raft nodes before linearized reading' (duration: 171.326329ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:10.702815Z","caller":"traceutil/trace.go:171","msg":"trace[279863045] transaction","detail":"{read_only:false; number_of_response:1; response_revision:680; }","duration":"129.427934ms","start":"2026-02-18T14:39:10.573371Z","end":"2026-02-18T14:39:10.702799Z","steps":["trace[279863045] 'process raft request' (duration: 124.059574ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:10.703185Z","caller":"traceutil/trace.go:171","msg":"trace[125778134] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"115.932524ms","start":"2026-02-18T14:39:10.587244Z","end":"2026-02-18T14:39:10.703176Z","steps":["trace[125778134] 'process raft request' (duration: 115.503036ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:12.470868Z","caller":"traceutil/trace.go:171","msg":"trace[1718656894] linearizableReadLoop","detail":"{readStateIndex:723; appliedIndex:722; }","duration":"117.005467ms","start":"2026-02-18T14:39:12.353845Z","end":"2026-02-18T14:39:12.470851Z","steps":["trace[1718656894] 'read index received' (duration: 116.851894ms)","trace[1718656894] 'applied index is now lower than readState.Index' (duration: 153.063µs)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:39:12.470962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.109339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:39:12.470978Z","caller":"traceutil/trace.go:171","msg":"trace[126972583] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:693; }","duration":"117.169909ms","start":"2026-02-18T14:39:12.353803Z","end":"2026-02-18T14:39:12.470973Z","steps":["trace[126972583] 'agreement among raft nodes before linearized reading' (duration: 117.109728ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:12.47122Z","caller":"traceutil/trace.go:171","msg":"trace[2107028691] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"145.078416ms","start":"2026-02-18T14:39:12.326135Z","end":"2026-02-18T14:39:12.471213Z","steps":["trace[2107028691] 'process raft request' (duration: 144.620938ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:17.549944Z","caller":"traceutil/trace.go:171","msg":"trace[879403408] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"100.470888ms","start":"2026-02-18T14:39:17.44945Z","end":"2026-02-18T14:39:17.549921Z","steps":["trace[879403408] 'process raft request' (duration: 100.355116ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:17.613322Z","caller":"traceutil/trace.go:171","msg":"trace[1999005706] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"118.94511ms","start":"2026-02-18T14:39:17.49436Z","end":"2026-02-18T14:39:17.613305Z","steps":["trace[1999005706] 'process raft request' (duration: 118.713186ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:17.818933Z","caller":"traceutil/trace.go:171","msg":"trace[561269014] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"192.53921ms","start":"2026-02-18T14:39:17.626377Z","end":"2026-02-18T14:39:17.818916Z","steps":["trace[561269014] 'process raft request' (duration: 192.226655ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:17.819473Z","caller":"traceutil/trace.go:171","msg":"trace[1623571143] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"191.37826ms","start":"2026-02-18T14:39:17.628082Z","end":"2026-02-18T14:39:17.81946Z","steps":["trace[1623571143] 'process raft request' (duration: 190.706648ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:17.819564Z","caller":"traceutil/trace.go:171","msg":"trace[786031523] linearizableReadLoop","detail":"{readStateIndex:777; appliedIndex:773; }","duration":"120.257212ms","start":"2026-02-18T14:39:17.699254Z","end":"2026-02-18T14:39:17.819511Z","steps":["trace[786031523] 'read index received' (duration: 119.417198ms)","trace[786031523] 'applied index is now lower than readState.Index' (duration: 839.124µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:39:17.819966Z","caller":"traceutil/trace.go:171","msg":"trace[1880058099] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"189.969394ms","start":"2026-02-18T14:39:17.629983Z","end":"2026-02-18T14:39:17.819952Z","steps":["trace[1880058099] 'process raft request' (duration: 189.287922ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:17.82035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.185247ms","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-18T14:39:17.820526Z","caller":"traceutil/trace.go:171","msg":"trace[447563826] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:746; }","duration":"160.378411ms","start":"2026-02-18T14:39:17.660102Z","end":"2026-02-18T14:39:17.82048Z","steps":["trace[447563826] 'agreement among raft nodes before linearized reading' (duration: 160.122947ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:17.820881Z","caller":"traceutil/trace.go:171","msg":"trace[1002700587] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"189.131741ms","start":"2026-02-18T14:39:17.631737Z","end":"2026-02-18T14:39:17.820869Z","steps":["trace[1002700587] 'process raft request' (duration: 187.693765ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:17.991933Z","caller":"traceutil/trace.go:171","msg":"trace[1627371108] linearizableReadLoop","detail":"{readStateIndex:779; appliedIndex:777; }","duration":"172.251797ms","start":"2026-02-18T14:39:17.819662Z","end":"2026-02-18T14:39:17.991913Z","steps":["trace[1627371108] 'read index received' (duration: 112.190532ms)","trace[1627371108] 'applied index is now lower than readState.Index' (duration: 60.060335ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:39:17.992116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.0499ms","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-18T14:39:17.992159Z","caller":"traceutil/trace.go:171","msg":"trace[1791852644] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:748; }","duration":"254.133111ms","start":"2026-02-18T14:39:17.738005Z","end":"2026-02-18T14:39:17.992138Z","steps":["trace[1791852644] 'agreement among raft nodes before linearized reading' (duration: 253.990039ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:17.992261Z","caller":"traceutil/trace.go:171","msg":"trace[674645349] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"206.335661ms","start":"2026-02-18T14:39:17.785881Z","end":"2026-02-18T14:39:17.992217Z","steps":["trace[674645349] 'process raft request' (duration: 205.983505ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:17.992447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.672095ms","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-18T14:39:17.992474Z","caller":"traceutil/trace.go:171","msg":"trace[1268035943] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"285.62738ms","start":"2026-02-18T14:39:17.706838Z","end":"2026-02-18T14:39:17.992465Z","steps":["trace[1268035943] 'process raft request' (duration: 224.985715ms)","trace[1268035943] 'compare' (duration: 59.910342ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:39:17.992476Z","caller":"traceutil/trace.go:171","msg":"trace[1484770673] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:748; }","duration":"252.711437ms","start":"2026-02-18T14:39:17.739756Z","end":"2026-02-18T14:39:17.992468Z","steps":["trace[1484770673] 'agreement among raft nodes before linearized reading' (duration: 252.631445ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:17.999513Z","caller":"traceutil/trace.go:171","msg":"trace[1871532403] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"167.039736ms","start":"2026-02-18T14:39:17.832455Z","end":"2026-02-18T14:39:17.999495Z","steps":["trace[1871532403] 'process raft request' (duration: 167.000915ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:17.999753Z","caller":"traceutil/trace.go:171","msg":"trace[616585701] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"172.616274ms","start":"2026-02-18T14:39:17.827132Z","end":"2026-02-18T14:39:17.999748Z","steps":["trace[616585701] 'process raft request' (duration: 172.234546ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:18.134996Z","caller":"traceutil/trace.go:171","msg":"trace[1716729666] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"123.891548ms","start":"2026-02-18T14:39:18.01109Z","end":"2026-02-18T14:39:18.134981Z","steps":["trace[1716729666] 'process raft request' (duration: 123.865437ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:18.135246Z","caller":"traceutil/trace.go:171","msg":"trace[1599605819] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"130.504032ms","start":"2026-02-18T14:39:18.004736Z","end":"2026-02-18T14:39:18.13524Z","steps":["trace[1599605819] 'process raft request' (duration: 114.395014ms)","trace[1599605819] 'compare' (duration: 15.686281ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:39:18.135351Z","caller":"traceutil/trace.go:171","msg":"trace[1785061880] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"130.478282ms","start":"2026-02-18T14:39:18.004869Z","end":"2026-02-18T14:39:18.135347Z","steps":["trace[1785061880] 'process raft request' (duration: 130.034224ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:18.13544Z","caller":"traceutil/trace.go:171","msg":"trace[1460085778] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"124.409616ms","start":"2026-02-18T14:39:18.011025Z","end":"2026-02-18T14:39:18.135435Z","steps":["trace[1460085778] 'process raft request' (duration: 123.910658ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:18.381137Z","caller":"traceutil/trace.go:171","msg":"trace[834936042] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"231.683187ms","start":"2026-02-18T14:39:18.149439Z","end":"2026-02-18T14:39:18.381122Z","steps":["trace[834936042] 'process raft request' (duration: 231.324241ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:18.587542Z","caller":"traceutil/trace.go:171","msg":"trace[2057053949] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"162.644506ms","start":"2026-02-18T14:39:18.424881Z","end":"2026-02-18T14:39:18.587525Z","steps":["trace[2057053949] 'process raft request' (duration: 106.035979ms)","trace[2057053949] 'compare' (duration: 56.100929ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:39:18.587823Z","caller":"traceutil/trace.go:171","msg":"trace[1465663030] linearizableReadLoop","detail":"{readStateIndex:791; appliedIndex:790; }","duration":"160.923596ms","start":"2026-02-18T14:39:18.426225Z","end":"2026-02-18T14:39:18.587148Z","steps":["trace[1465663030] 'read index received' (duration: 2.845959ms)","trace[1465663030] 'applied index is now lower than readState.Index' (duration: 158.076827ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:39:18.587978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.73604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-v252j\" ","response":"range_response_count:1 size:4732"} {"level":"info","ts":"2026-02-18T14:39:18.588009Z","caller":"traceutil/trace.go:171","msg":"trace[93473835] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-v252j; range_end:; response_count:1; response_revision:760; }","duration":"161.791821ms","start":"2026-02-18T14:39:18.426206Z","end":"2026-02-18T14:39:18.587998Z","steps":["trace[93473835] 'agreement among raft nodes before linearized reading' (duration: 161.673809ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:18.668755Z","caller":"traceutil/trace.go:171","msg":"trace[1437303701] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"226.279043ms","start":"2026-02-18T14:39:18.442455Z","end":"2026-02-18T14:39:18.668735Z","steps":["trace[1437303701] 'process raft request' (duration: 226.235322ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:18.669045Z","caller":"traceutil/trace.go:171","msg":"trace[1847348824] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"235.179047ms","start":"2026-02-18T14:39:18.433857Z","end":"2026-02-18T14:39:18.669036Z","steps":["trace[1847348824] 'process raft request' (duration: 234.617717ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:18.669469Z","caller":"traceutil/trace.go:171","msg":"trace[437021665] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"235.474612ms","start":"2026-02-18T14:39:18.433982Z","end":"2026-02-18T14:39:18.669457Z","steps":["trace[437021665] 'process raft request' (duration: 234.619587ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:18.670237Z","caller":"traceutil/trace.go:171","msg":"trace[430890610] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"235.257899ms","start":"2026-02-18T14:39:18.434465Z","end":"2026-02-18T14:39:18.669723Z","steps":["trace[430890610] 'process raft request' (duration: 234.18439ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:18.671077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.241119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:39:18.671125Z","caller":"traceutil/trace.go:171","msg":"trace[1503840915] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:764; }","duration":"184.33117ms","start":"2026-02-18T14:39:18.486783Z","end":"2026-02-18T14:39:18.671114Z","steps":["trace[1503840915] 'agreement among raft nodes before linearized reading' (duration: 184.249219ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:18.842006Z","caller":"traceutil/trace.go:171","msg":"trace[236912703] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"247.653262ms","start":"2026-02-18T14:39:18.594334Z","end":"2026-02-18T14:39:18.841987Z","steps":["trace[236912703] 'process raft request' (duration: 247.53989ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:18.883829Z","caller":"traceutil/trace.go:171","msg":"trace[642406743] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"206.593035ms","start":"2026-02-18T14:39:18.677219Z","end":"2026-02-18T14:39:18.883812Z","steps":["trace[642406743] 'process raft request' (duration: 206.501613ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:19.131Z","caller":"traceutil/trace.go:171","msg":"trace[225408621] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"282.863721ms","start":"2026-02-18T14:39:18.848116Z","end":"2026-02-18T14:39:19.13098Z","steps":["trace[225408621] 'process raft request' (duration: 282.715839ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:19.131096Z","caller":"traceutil/trace.go:171","msg":"trace[1256124190] linearizableReadLoop","detail":"{readStateIndex:798; appliedIndex:797; }","duration":"282.885602ms","start":"2026-02-18T14:39:18.848202Z","end":"2026-02-18T14:39:19.131087Z","steps":["trace[1256124190] 'read index received' (duration: 36.179184ms)","trace[1256124190] 'applied index is now lower than readState.Index' (duration: 246.705958ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:39:19.131188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.975454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-v252j\" ","response":"range_response_count:1 size:5025"} {"level":"info","ts":"2026-02-18T14:39:19.131203Z","caller":"traceutil/trace.go:171","msg":"trace[1903093577] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-v252j; range_end:; response_count:1; response_revision:768; }","duration":"283.021334ms","start":"2026-02-18T14:39:18.848176Z","end":"2026-02-18T14:39:19.131198Z","steps":["trace[1903093577] 'agreement among raft nodes before linearized reading' (duration: 282.938043ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:19.131357Z","caller":"traceutil/trace.go:171","msg":"trace[864759873] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"280.140984ms","start":"2026-02-18T14:39:18.851211Z","end":"2026-02-18T14:39:19.131352Z","steps":["trace[864759873] 'process raft request' (duration: 279.740497ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:19.277869Z","caller":"traceutil/trace.go:171","msg":"trace[831017241] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"382.452888ms","start":"2026-02-18T14:39:18.895397Z","end":"2026-02-18T14:39:19.27785Z","steps":["trace[831017241] 'process raft request' (duration: 382.335776ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:19.278012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:18.895381Z","time spent":"382.547461ms","remote":"127.0.0.1:54628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4191,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T14:39:19.278549Z","caller":"traceutil/trace.go:171","msg":"trace[946759135] linearizableReadLoop","detail":"{readStateIndex:800; appliedIndex:800; }","duration":"139.71511ms","start":"2026-02-18T14:39:19.138823Z","end":"2026-02-18T14:39:19.278538Z","steps":["trace[946759135] 'read index received' (duration: 139.71126ms)","trace[946759135] 'applied index is now lower than readState.Index' (duration: 3.1µs)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:39:19.278628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.795951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-18T14:39:19.278655Z","caller":"traceutil/trace.go:171","msg":"trace[1408507417] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:769; }","duration":"139.846623ms","start":"2026-02-18T14:39:19.1388Z","end":"2026-02-18T14:39:19.278647Z","steps":["trace[1408507417] 'agreement among raft nodes before linearized reading' (duration: 139.790502ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:19.432581Z","caller":"traceutil/trace.go:171","msg":"trace[934239344] linearizableReadLoop","detail":"{readStateIndex:801; appliedIndex:800; }","duration":"153.949513ms","start":"2026-02-18T14:39:19.278575Z","end":"2026-02-18T14:39:19.432524Z","steps":["trace[934239344] 'read index received' (duration: 100.896255ms)","trace[934239344] 'applied index is now lower than readState.Index' (duration: 53.052378ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:39:19.432833Z","caller":"traceutil/trace.go:171","msg":"trace[830949498] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"291.928154ms","start":"2026-02-18T14:39:19.140891Z","end":"2026-02-18T14:39:19.432819Z","steps":["trace[830949498] 'process raft request' (duration: 238.53289ms)","trace[830949498] 'compare' (duration: 53.011378ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:39:19.433087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.176482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:39:19.433127Z","caller":"traceutil/trace.go:171","msg":"trace[1700672822] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:770; }","duration":"294.236403ms","start":"2026-02-18T14:39:19.138881Z","end":"2026-02-18T14:39:19.433118Z","steps":["trace[1700672822] 'agreement among raft nodes before linearized reading' (duration: 294.153962ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:19.771507Z","caller":"traceutil/trace.go:171","msg":"trace[52826866] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"328.217115ms","start":"2026-02-18T14:39:19.443108Z","end":"2026-02-18T14:39:19.771325Z","steps":["trace[52826866] 'process raft request' (duration: 328.007132ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:19.771894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:19.443093Z","time spent":"328.700353ms","remote":"127.0.0.1:54458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1613,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T14:39:20.157586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.559315ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T14:39:20.157691Z","caller":"traceutil/trace.go:171","msg":"trace[788411542] linearizableReadLoop","detail":"{readStateIndex:804; appliedIndex:802; }","duration":"453.633409ms","start":"2026-02-18T14:39:19.704047Z","end":"2026-02-18T14:39:20.15768Z","steps":["trace[788411542] 'read index received' (duration: 72.015512ms)","trace[788411542] 'applied index is now lower than readState.Index' (duration: 381.617137ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:39:20.157852Z","caller":"traceutil/trace.go:171","msg":"trace[1490039270] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"713.88094ms","start":"2026-02-18T14:39:19.443961Z","end":"2026-02-18T14:39:20.157842Z","steps":["trace[1490039270] 'process raft request' (duration: 529.01309ms)","trace[1490039270] 'compare' (duration: 184.482604ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:39:20.157887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:19.443952Z","time spent":"713.917401ms","remote":"127.0.0.1:54652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3866,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T14:39:20.158059Z","caller":"traceutil/trace.go:171","msg":"trace[176108400] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"714.046814ms","start":"2026-02-18T14:39:19.444008Z","end":"2026-02-18T14:39:20.158055Z","steps":["trace[176108400] 'process raft request' (duration: 713.635717ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:20.158086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:19.444003Z","time spent":"714.067594ms","remote":"127.0.0.1:54366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":901,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T14:39:20.158193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.150457ms","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-18T14:39:20.158215Z","caller":"traceutil/trace.go:171","msg":"trace[1441918412] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:773; }","duration":"454.193257ms","start":"2026-02-18T14:39:19.704016Z","end":"2026-02-18T14:39:20.158209Z","steps":["trace[1441918412] 'agreement among raft nodes before linearized reading' (duration: 454.126616ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:20.158228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:19.703999Z","time spent":"454.226539ms","remote":"127.0.0.1:54450","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-18T14:39:20.158334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.519385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-18T14:39:20.158367Z","caller":"traceutil/trace.go:171","msg":"trace[1826222193] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:773; }","duration":"329.564617ms","start":"2026-02-18T14:39:19.828778Z","end":"2026-02-18T14:39:20.158342Z","steps":["trace[1826222193] 'agreement among raft nodes before linearized reading' (duration: 329.526626ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:20.15838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:19.828759Z","time spent":"329.617737ms","remote":"127.0.0.1:54450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-18T14:39:20.159254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.092957ms","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-18T14:39:20.159272Z","caller":"traceutil/trace.go:171","msg":"trace[169252551] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:773; }","duration":"153.151717ms","start":"2026-02-18T14:39:20.006115Z","end":"2026-02-18T14:39:20.159267Z","steps":["trace[169252551] 'agreement among raft nodes before linearized reading' (duration: 153.098936ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:20.590959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.361983ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T14:39:20.591023Z","caller":"traceutil/trace.go:171","msg":"trace[1167396681] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"421.040533ms","start":"2026-02-18T14:39:20.169971Z","end":"2026-02-18T14:39:20.591011Z","steps":["trace[1167396681] 'process raft request' (duration: 221.576169ms)","trace[1167396681] 'compare' (duration: 199.280991ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:39:20.591051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:20.169952Z","time spent":"421.085695ms","remote":"127.0.0.1:54450","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-18T14:39:20.863618Z","caller":"traceutil/trace.go:171","msg":"trace[991340620] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:804; }","duration":"597.105169ms","start":"2026-02-18T14:39:20.266496Z","end":"2026-02-18T14:39:20.863602Z","steps":["trace[991340620] 'read index received' (duration: 125.057341ms)","trace[991340620] 'applied index is now lower than readState.Index' (duration: 472.047228ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:39:20.863913Z","caller":"traceutil/trace.go:171","msg":"trace[2076018174] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"692.862783ms","start":"2026-02-18T14:39:20.171042Z","end":"2026-02-18T14:39:20.863905Z","steps":["trace[2076018174] 'process raft request' (duration: 692.319614ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:20.863987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:20.171034Z","time spent":"692.903525ms","remote":"127.0.0.1:54628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4182,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T14:39:20.864184Z","caller":"traceutil/trace.go:171","msg":"trace[1683481500] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"691.546142ms","start":"2026-02-18T14:39:20.172631Z","end":"2026-02-18T14:39:20.864177Z","steps":["trace[1683481500] 'process raft request' (duration: 690.85417ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:20.864227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:20.172622Z","time spent":"691.585452ms","remote":"127.0.0.1:54450","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-18T14:39:20.864312Z","caller":"traceutil/trace.go:171","msg":"trace[565341214] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"688.831786ms","start":"2026-02-18T14:39:20.175475Z","end":"2026-02-18T14:39:20.864307Z","steps":["trace[565341214] 'process raft request' (duration: 688.040723ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:20.864343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:20.175468Z","time spent":"688.858366ms","remote":"127.0.0.1:54450","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-18T14:39:20.864533Z","caller":"traceutil/trace.go:171","msg":"trace[296003839] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"687.383901ms","start":"2026-02-18T14:39:20.177142Z","end":"2026-02-18T14:39:20.864526Z","steps":["trace[296003839] 'process raft request' (duration: 686.438415ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:20.86457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:20.177136Z","time spent":"687.414051ms","remote":"127.0.0.1:54450","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-18T14:39:20.864677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.177187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-18T14:39:20.864699Z","caller":"traceutil/trace.go:171","msg":"trace[2093484310] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:779; }","duration":"598.224968ms","start":"2026-02-18T14:39:20.266466Z","end":"2026-02-18T14:39:20.864691Z","steps":["trace[2093484310] 'agreement among raft nodes before linearized reading' (duration: 598.187628ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:20.864718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:20.266452Z","time spent":"598.261109ms","remote":"127.0.0.1:54638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":2,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"info","ts":"2026-02-18T14:39:20.86443Z","caller":"traceutil/trace.go:171","msg":"trace[186798108] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"688.277257ms","start":"2026-02-18T14:39:20.176147Z","end":"2026-02-18T14:39:20.864424Z","steps":["trace[186798108] 'process raft request' (duration: 687.404323ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:20.865263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:20.17614Z","time spent":"689.099311ms","remote":"127.0.0.1:54450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T14:39:21.062595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.90967ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-18T14:39:21.062665Z","caller":"traceutil/trace.go:171","msg":"trace[1046328713] linearizableReadLoop","detail":"{readStateIndex:811; appliedIndex:810; }","duration":"198.958087ms","start":"2026-02-18T14:39:20.863695Z","end":"2026-02-18T14:39:21.062653Z","steps":["trace[1046328713] 'read index received' (duration: 79.954486ms)","trace[1046328713] 'applied index is now lower than readState.Index' (duration: 119.002991ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:39:21.062778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.095998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-mr86f\" ","response":"range_response_count:1 size:4820"} {"level":"info","ts":"2026-02-18T14:39:21.062792Z","caller":"traceutil/trace.go:171","msg":"trace[1879098758] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-mr86f; range_end:; response_count:1; response_revision:780; }","duration":"631.112838ms","start":"2026-02-18T14:39:20.431675Z","end":"2026-02-18T14:39:21.062787Z","steps":["trace[1879098758] 'agreement among raft nodes before linearized reading' (duration: 631.005846ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:39:21.062808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:20.431637Z","time spent":"631.166759ms","remote":"127.0.0.1:54382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":4843,"request content":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-mr86f\" "} {"level":"info","ts":"2026-02-18T14:39:21.062926Z","caller":"traceutil/trace.go:171","msg":"trace[1762233120] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"630.421526ms","start":"2026-02-18T14:39:20.432498Z","end":"2026-02-18T14:39:21.06292Z","steps":["trace[1762233120] 'process raft request' (duration: 511.12824ms)","trace[1762233120] 'compare' (duration: 118.663276ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:39:21.06295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:39:20.432485Z","time spent":"630.453277ms","remote":"127.0.0.1:54252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":723,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T14:39:24.781205Z","caller":"traceutil/trace.go:171","msg":"trace[636865605] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"162.362195ms","start":"2026-02-18T14:39:24.618821Z","end":"2026-02-18T14:39:24.781183Z","steps":["trace[636865605] 'process raft request' (duration: 162.224693ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:43.27705Z","caller":"traceutil/trace.go:171","msg":"trace[743832395] transaction","detail":"{read_only:false; response_revision:854; number_of_response:1; }","duration":"140.52924ms","start":"2026-02-18T14:39:43.136488Z","end":"2026-02-18T14:39:43.277018Z","steps":["trace[743832395] 'process raft request' (duration: 137.099432ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:43.317073Z","caller":"traceutil/trace.go:171","msg":"trace[1358307901] transaction","detail":"{read_only:false; response_revision:855; number_of_response:1; }","duration":"150.448662ms","start":"2026-02-18T14:39:43.166606Z","end":"2026-02-18T14:39:43.317054Z","steps":["trace[1358307901] 'process raft request' (duration: 150.038276ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:53.431607Z","caller":"traceutil/trace.go:171","msg":"trace[1363524345] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"104.887898ms","start":"2026-02-18T14:39:53.326702Z","end":"2026-02-18T14:39:53.43159Z","steps":["trace[1363524345] 'process raft request' (duration: 55.509749ms)","trace[1363524345] 'compare' (duration: 49.150286ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:39:53.556245Z","caller":"traceutil/trace.go:171","msg":"trace[312449744] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"120.405704ms","start":"2026-02-18T14:39:53.435813Z","end":"2026-02-18T14:39:53.556218Z","steps":["trace[312449744] 'process raft request' (duration: 118.50944ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:39:53.568175Z","caller":"traceutil/trace.go:171","msg":"trace[1812663812] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"129.837429ms","start":"2026-02-18T14:39:53.438178Z","end":"2026-02-18T14:39:53.568015Z","steps":["trace[1812663812] 'process raft request' (duration: 129.735738ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:40:03.368544Z","caller":"traceutil/trace.go:171","msg":"trace[788706321] linearizableReadLoop","detail":"{readStateIndex:947; appliedIndex:946; }","duration":"152.719996ms","start":"2026-02-18T14:40:03.215809Z","end":"2026-02-18T14:40:03.368529Z","steps":["trace[788706321] 'read index received' (duration: 152.611445ms)","trace[788706321] 'applied index is now lower than readState.Index' (duration: 107.971µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:40:03.368629Z","caller":"traceutil/trace.go:171","msg":"trace[1279052533] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"200.685878ms","start":"2026-02-18T14:40:03.167938Z","end":"2026-02-18T14:40:03.368624Z","steps":["trace[1279052533] 'process raft request' (duration: 200.490586ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:03.368833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.01139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:40:03.368855Z","caller":"traceutil/trace.go:171","msg":"trace[814565689] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:907; }","duration":"153.059421ms","start":"2026-02-18T14:40:03.215789Z","end":"2026-02-18T14:40:03.368848Z","steps":["trace[814565689] 'agreement among raft nodes before linearized reading' (duration: 153.015951ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:40:03.593574Z","caller":"traceutil/trace.go:171","msg":"trace[1265449437] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"141.094501ms","start":"2026-02-18T14:40:03.452464Z","end":"2026-02-18T14:40:03.593558Z","steps":["trace[1265449437] 'process raft request' (duration: 141.0668ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:40:03.59372Z","caller":"traceutil/trace.go:171","msg":"trace[641733985] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"216.8286ms","start":"2026-02-18T14:40:03.376886Z","end":"2026-02-18T14:40:03.593714Z","steps":["trace[641733985] 'process raft request' (duration: 130.321735ms)","trace[641733985] 'compare' (duration: 86.230672ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:40:04.39011Z","caller":"traceutil/trace.go:171","msg":"trace[1325072311] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"128.220349ms","start":"2026-02-18T14:40:04.261871Z","end":"2026-02-18T14:40:04.390092Z","steps":["trace[1325072311] 'process raft request' (duration: 128.093458ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:05.832614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.107362ms","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-18T14:40:05.832669Z","caller":"traceutil/trace.go:171","msg":"trace[374829705] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:917; }","duration":"104.176553ms","start":"2026-02-18T14:40:05.72848Z","end":"2026-02-18T14:40:05.832657Z","steps":["trace[374829705] 'range keys from in-memory index tree' (duration: 103.980589ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:40:11.716037Z","caller":"traceutil/trace.go:171","msg":"trace[1358931330] linearizableReadLoop","detail":"{readStateIndex:972; appliedIndex:971; }","duration":"241.707203ms","start":"2026-02-18T14:40:11.47431Z","end":"2026-02-18T14:40:11.716017Z","steps":["trace[1358931330] 'read index received' (duration: 241.544161ms)","trace[1358931330] 'applied index is now lower than readState.Index' (duration: 162.212µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:40:11.716465Z","caller":"traceutil/trace.go:171","msg":"trace[939559210] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"263.256531ms","start":"2026-02-18T14:40:11.453194Z","end":"2026-02-18T14:40:11.71645Z","steps":["trace[939559210] 'process raft request' (duration: 262.682635ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:11.716738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.685715ms","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-18T14:40:11.719152Z","caller":"traceutil/trace.go:171","msg":"trace[1873115926] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:930; }","duration":"146.189336ms","start":"2026-02-18T14:40:11.572944Z","end":"2026-02-18T14:40:11.719134Z","steps":["trace[1873115926] 'agreement among raft nodes before linearized reading' (duration: 143.627875ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:11.716904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.595983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-18T14:40:11.721679Z","caller":"traceutil/trace.go:171","msg":"trace[1825479648] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:930; }","duration":"247.394631ms","start":"2026-02-18T14:40:11.474267Z","end":"2026-02-18T14:40:11.721661Z","steps":["trace[1825479648] 'agreement among raft nodes before linearized reading' (duration: 242.505402ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:11.718037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.996963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12727"} {"level":"info","ts":"2026-02-18T14:40:11.722506Z","caller":"traceutil/trace.go:171","msg":"trace[909843532] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:930; }","duration":"105.498857ms","start":"2026-02-18T14:40:11.61699Z","end":"2026-02-18T14:40:11.722488Z","steps":["trace[909843532] 'agreement among raft nodes before linearized reading' (duration: 100.932131ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:40:12.125951Z","caller":"traceutil/trace.go:171","msg":"trace[2079557243] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"401.509744ms","start":"2026-02-18T14:40:11.724423Z","end":"2026-02-18T14:40:12.125933Z","steps":["trace[2079557243] 'process raft request' (duration: 337.772002ms)","trace[2079557243] 'compare' (duration: 63.365248ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:40:12.126044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:40:11.724409Z","time spent":"401.586985ms","remote":"127.0.0.1:54450","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-18T14:40:12.213594Z","caller":"traceutil/trace.go:171","msg":"trace[2139084724] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"484.450164ms","start":"2026-02-18T14:40:11.729126Z","end":"2026-02-18T14:40:12.213577Z","steps":["trace[2139084724] 'process raft request' (duration: 484.330163ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:12.213716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:40:11.729115Z","time spent":"484.540685ms","remote":"127.0.0.1:54450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T14:40:12.213791Z","caller":"traceutil/trace.go:171","msg":"trace[1312492542] linearizableReadLoop","detail":"{readStateIndex:975; appliedIndex:972; }","duration":"188.212038ms","start":"2026-02-18T14:40:12.02556Z","end":"2026-02-18T14:40:12.213772Z","steps":["trace[1312492542] 'read index received' (duration: 36.653067ms)","trace[1312492542] 'applied index is now lower than readState.Index' (duration: 151.557811ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:40:12.213934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.360029ms","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-18T14:40:12.213957Z","caller":"traceutil/trace.go:171","msg":"trace[113057821] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:933; }","duration":"188.417821ms","start":"2026-02-18T14:40:12.025532Z","end":"2026-02-18T14:40:12.213949Z","steps":["trace[113057821] 'agreement among raft nodes before linearized reading' (duration: 188.302319ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:40:12.214028Z","caller":"traceutil/trace.go:171","msg":"trace[1716321654] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"484.85356ms","start":"2026-02-18T14:40:11.729168Z","end":"2026-02-18T14:40:12.214021Z","steps":["trace[1716321654] 'process raft request' (duration: 484.380833ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:12.21406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:40:11.729164Z","time spent":"484.87815ms","remote":"127.0.0.1:54450","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-18T14:40:14.095761Z","caller":"traceutil/trace.go:171","msg":"trace[2146543104] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"317.903492ms","start":"2026-02-18T14:40:13.77783Z","end":"2026-02-18T14:40:14.095734Z","steps":["trace[2146543104] 'process raft request' (duration: 317.74399ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:14.095941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:40:13.777813Z","time spent":"318.037404ms","remote":"127.0.0.1:54450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T14:40:14.45145Z","caller":"traceutil/trace.go:171","msg":"trace[905228775] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"113.195478ms","start":"2026-02-18T14:40:14.338229Z","end":"2026-02-18T14:40:14.451425Z","steps":["trace[905228775] 'process raft request' (duration: 96.898315ms)","trace[905228775] 'compare' (duration: 16.147981ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:40:14.451891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.233404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:40:14.451919Z","caller":"traceutil/trace.go:171","msg":"trace[2041391915] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:940; }","duration":"100.318045ms","start":"2026-02-18T14:40:14.351591Z","end":"2026-02-18T14:40:14.451909Z","steps":["trace[2041391915] 'agreement among raft nodes before linearized reading' (duration: 100.259765ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:40:15.970997Z","caller":"traceutil/trace.go:171","msg":"trace[19556326] linearizableReadLoop","detail":"{readStateIndex:984; appliedIndex:983; }","duration":"163.234601ms","start":"2026-02-18T14:40:15.807738Z","end":"2026-02-18T14:40:15.970972Z","steps":["trace[19556326] 'read index received' (duration: 162.877067ms)","trace[19556326] 'applied index is now lower than readState.Index' (duration: 356.324µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:40:15.971241Z","caller":"traceutil/trace.go:171","msg":"trace[1244107804] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"204.224792ms","start":"2026-02-18T14:40:15.767005Z","end":"2026-02-18T14:40:15.97123Z","steps":["trace[1244107804] 'process raft request' (duration: 203.802357ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:15.971787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.01559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.62\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-18T14:40:15.971888Z","caller":"traceutil/trace.go:171","msg":"trace[1350192526] range","detail":"{range_begin:/registry/masterleases/162.253.55.62; range_end:; response_count:1; response_revision:942; }","duration":"164.154731ms","start":"2026-02-18T14:40:15.80771Z","end":"2026-02-18T14:40:15.971865Z","steps":["trace[1350192526] 'agreement among raft nodes before linearized reading' (duration: 163.920429ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:20.821696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.973684ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T14:40:20.821835Z","caller":"traceutil/trace.go:171","msg":"trace[1174586345] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"243.441364ms","start":"2026-02-18T14:40:20.578371Z","end":"2026-02-18T14:40:20.821812Z","steps":["trace[1174586345] 'process raft request' (duration: 98.163757ms)","trace[1174586345] 'compare' (duration: 144.836102ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:40:20.990367Z","caller":"traceutil/trace.go:171","msg":"trace[256587653] transaction","detail":"{read_only:false; number_of_response:1; response_revision:974; }","duration":"118.864494ms","start":"2026-02-18T14:40:20.871485Z","end":"2026-02-18T14:40:20.990349Z","steps":["trace[256587653] 'process raft request' (duration: 112.159368ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:40:21.803688Z","caller":"traceutil/trace.go:171","msg":"trace[507945749] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"163.877593ms","start":"2026-02-18T14:40:21.639789Z","end":"2026-02-18T14:40:21.803666Z","steps":["trace[507945749] 'process raft request' (duration: 163.492738ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:40:25.969914Z","caller":"traceutil/trace.go:171","msg":"trace[1793626498] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"146.462982ms","start":"2026-02-18T14:40:25.823424Z","end":"2026-02-18T14:40:25.969886Z","steps":["trace[1793626498] 'process raft request' (duration: 88.946526ms)","trace[1793626498] 'compare' (duration: 57.414235ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:40:26.878623Z","caller":"traceutil/trace.go:171","msg":"trace[1485879597] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"144.633664ms","start":"2026-02-18T14:40:26.733968Z","end":"2026-02-18T14:40:26.878602Z","steps":["trace[1485879597] 'process raft request' (duration: 144.345861ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:28.559598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.071438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:40:28.559703Z","caller":"traceutil/trace.go:171","msg":"trace[903772629] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1008; }","duration":"205.277081ms","start":"2026-02-18T14:40:28.354406Z","end":"2026-02-18T14:40:28.559683Z","steps":["trace[903772629] 'range keys from in-memory index tree' (duration: 204.989688ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:40:28.669448Z","caller":"traceutil/trace.go:171","msg":"trace[1362687182] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"103.152292ms","start":"2026-02-18T14:40:28.566253Z","end":"2026-02-18T14:40:28.669406Z","steps":["trace[1362687182] 'process raft request' (duration: 102.98089ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:40:29.232096Z","caller":"traceutil/trace.go:171","msg":"trace[706950807] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"274.422124ms","start":"2026-02-18T14:40:28.957644Z","end":"2026-02-18T14:40:29.232066Z","steps":["trace[706950807] 'process raft request' (duration: 246.007331ms)","trace[706950807] 'compare' (duration: 28.252741ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:40:32.888244Z","caller":"traceutil/trace.go:171","msg":"trace[104195458] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"191.505014ms","start":"2026-02-18T14:40:32.69672Z","end":"2026-02-18T14:40:32.888225Z","steps":["trace[104195458] 'process raft request' (duration: 191.377233ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:40:33.452825Z","caller":"traceutil/trace.go:171","msg":"trace[459404333] linearizableReadLoop","detail":"{readStateIndex:1074; appliedIndex:1073; }","duration":"184.093964ms","start":"2026-02-18T14:40:33.268709Z","end":"2026-02-18T14:40:33.452803Z","steps":["trace[459404333] 'read index received' (duration: 183.924573ms)","trace[459404333] 'applied index is now lower than readState.Index' (duration: 168.381µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:40:33.453197Z","caller":"traceutil/trace.go:171","msg":"trace[1334989574] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"201.238649ms","start":"2026-02-18T14:40:33.251939Z","end":"2026-02-18T14:40:33.453178Z","steps":["trace[1334989574] 'process raft request' (duration: 200.741174ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:33.453696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.974804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:40:33.453769Z","caller":"traceutil/trace.go:171","msg":"trace[1753640935] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1027; }","duration":"185.052854ms","start":"2026-02-18T14:40:33.268699Z","end":"2026-02-18T14:40:33.453752Z","steps":["trace[1753640935] 'agreement among raft nodes before linearized reading' (duration: 184.933893ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:40:34.414073Z","caller":"traceutil/trace.go:171","msg":"trace[1782474755] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"344.395215ms","start":"2026-02-18T14:40:34.064318Z","end":"2026-02-18T14:40:34.408713Z","steps":["trace[1782474755] 'process raft request' (duration: 344.005911ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:34.414359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:40:34.064298Z","time spent":"349.988565ms","remote":"127.0.0.1:54450","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-18T14:40:34.624973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.540119ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T14:40:34.625068Z","caller":"traceutil/trace.go:171","msg":"trace[1506753886] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"207.680612ms","start":"2026-02-18T14:40:34.41737Z","end":"2026-02-18T14:40:34.62505Z","steps":["trace[1506753886] 'process raft request' (duration: 102.976971ms)","trace[1506753886] 'compare' (duration: 104.415118ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:40:45.355584Z","caller":"traceutil/trace.go:171","msg":"trace[513270789] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"119.480196ms","start":"2026-02-18T14:40:45.236078Z","end":"2026-02-18T14:40:45.355558Z","steps":["trace[513270789] 'process raft request' (duration: 28.368314ms)","trace[513270789] 'compare' (duration: 90.840399ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:40:46.617356Z","caller":"traceutil/trace.go:171","msg":"trace[1824704501] linearizableReadLoop","detail":"{readStateIndex:1119; appliedIndex:1118; }","duration":"141.014503ms","start":"2026-02-18T14:40:46.476321Z","end":"2026-02-18T14:40:46.617336Z","steps":["trace[1824704501] 'read index received' (duration: 140.847451ms)","trace[1824704501] 'applied index is now lower than readState.Index' (duration: 166.282µs)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:40:46.61752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.177665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:statefulset-controller\" ","response":"range_response_count:1 size:763"} {"level":"info","ts":"2026-02-18T14:40:46.617564Z","caller":"traceutil/trace.go:171","msg":"trace[1798913998] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:statefulset-controller; range_end:; response_count:1; response_revision:1068; }","duration":"141.246135ms","start":"2026-02-18T14:40:46.476304Z","end":"2026-02-18T14:40:46.617551Z","steps":["trace[1798913998] 'agreement among raft nodes before linearized reading' (duration: 141.137644ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:40:46.617826Z","caller":"traceutil/trace.go:171","msg":"trace[1340060392] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"142.450098ms","start":"2026-02-18T14:40:46.475364Z","end":"2026-02-18T14:40:46.617815Z","steps":["trace[1340060392] 'process raft request' (duration: 141.860781ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:46.618331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.815616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:service-controller\" ","response":"range_response_count:1 size:747"} {"level":"info","ts":"2026-02-18T14:40:46.618372Z","caller":"traceutil/trace.go:171","msg":"trace[1725821905] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:service-controller; range_end:; response_count:1; response_revision:1068; }","duration":"124.868948ms","start":"2026-02-18T14:40:46.493491Z","end":"2026-02-18T14:40:46.61836Z","steps":["trace[1725821905] 'agreement among raft nodes before linearized reading' (duration: 124.697446ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:46.848804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.310034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:statefulset-controller\" ","response":"range_response_count:1 size:763"} {"level":"info","ts":"2026-02-18T14:40:46.848877Z","caller":"traceutil/trace.go:171","msg":"trace[1699826281] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:statefulset-controller; range_end:; response_count:1; response_revision:1068; }","duration":"164.412325ms","start":"2026-02-18T14:40:46.684448Z","end":"2026-02-18T14:40:46.848861Z","steps":["trace[1699826281] 'range keys from in-memory index tree' (duration: 164.254863ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:46.849254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.683976ms","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-18T14:40:46.849339Z","caller":"traceutil/trace.go:171","msg":"trace[818670761] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1068; }","duration":"161.798847ms","start":"2026-02-18T14:40:46.687531Z","end":"2026-02-18T14:40:46.849329Z","steps":["trace[818670761] 'range keys from in-memory index tree' (duration: 161.576225ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:46.849679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.277015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:ttl-after-finished-controller\" ","response":"range_response_count:1 size:791"} {"level":"info","ts":"2026-02-18T14:40:46.849714Z","caller":"traceutil/trace.go:171","msg":"trace[1583269133] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:ttl-after-finished-controller; range_end:; response_count:1; response_revision:1068; }","duration":"138.340285ms","start":"2026-02-18T14:40:46.711365Z","end":"2026-02-18T14:40:46.849705Z","steps":["trace[1583269133] 'range keys from in-memory index tree' (duration: 137.078693ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:40:53.488933Z","caller":"traceutil/trace.go:171","msg":"trace[1724681347] linearizableReadLoop","detail":"{readStateIndex:1136; appliedIndex:1135; }","duration":"462.889518ms","start":"2026-02-18T14:40:53.02602Z","end":"2026-02-18T14:40:53.48891Z","steps":["trace[1724681347] 'read index received' (duration: 462.721056ms)","trace[1724681347] 'applied index is now lower than readState.Index' (duration: 167.382µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:40:53.489232Z","caller":"traceutil/trace.go:171","msg":"trace[1021167534] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"502.360966ms","start":"2026-02-18T14:40:52.986842Z","end":"2026-02-18T14:40:53.489203Z","steps":["trace[1021167534] 'process raft request' (duration: 501.91104ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:53.489396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:40:52.986834Z","time spent":"502.471997ms","remote":"127.0.0.1:54450","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-18T14:40:53.489723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.678196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"} {"level":"info","ts":"2026-02-18T14:40:53.489898Z","caller":"traceutil/trace.go:171","msg":"trace[1840657655] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1084; }","duration":"463.834258ms","start":"2026-02-18T14:40:53.026016Z","end":"2026-02-18T14:40:53.48985Z","steps":["trace[1840657655] 'agreement among raft nodes before linearized reading' (duration: 463.435264ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:53.490104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:40:53.025976Z","time spent":"464.11295ms","remote":"127.0.0.1:54358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":1488,"request content":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" "} {"level":"warn","ts":"2026-02-18T14:40:53.489922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.859963ms","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-18T14:40:53.4906Z","caller":"traceutil/trace.go:171","msg":"trace[1165578818] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1084; }","duration":"230.533139ms","start":"2026-02-18T14:40:53.260027Z","end":"2026-02-18T14:40:53.49056Z","steps":["trace[1165578818] 'agreement among raft nodes before linearized reading' (duration: 229.811662ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:53.489823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.627086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:40:53.491361Z","caller":"traceutil/trace.go:171","msg":"trace[1393313054] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1084; }","duration":"134.186161ms","start":"2026-02-18T14:40:53.35716Z","end":"2026-02-18T14:40:53.491347Z","steps":["trace[1393313054] 'agreement among raft nodes before linearized reading' (duration: 132.645696ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:53.489987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.401663ms","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-18T14:40:53.492082Z","caller":"traceutil/trace.go:171","msg":"trace[781449695] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1084; }","duration":"307.527574ms","start":"2026-02-18T14:40:53.18454Z","end":"2026-02-18T14:40:53.492068Z","steps":["trace[781449695] 'agreement among raft nodes before linearized reading' (duration: 305.397253ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:53.492305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:40:53.184524Z","time spent":"307.739956ms","remote":"127.0.0.1:54450","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-18T14:40:53.490019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.744434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/default/\" range_end:\"/registry/rolebindings/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:40:53.492804Z","caller":"traceutil/trace.go:171","msg":"trace[1816182696] range","detail":"{range_begin:/registry/rolebindings/default/; range_end:/registry/rolebindings/default0; response_count:0; response_revision:1084; }","duration":"426.546371ms","start":"2026-02-18T14:40:53.066243Z","end":"2026-02-18T14:40:53.492789Z","steps":["trace[1816182696] 'agreement among raft nodes before linearized reading' (duration: 423.757953ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:53.493152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:40:53.066228Z","time spent":"426.902265ms","remote":"127.0.0.1:54512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":28,"request content":"key:\"/registry/rolebindings/default/\" range_end:\"/registry/rolebindings/default0\" limit:500 "} {"level":"warn","ts":"2026-02-18T14:40:53.489778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.869177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-node-lease/\" range_end:\"/registry/rolebindings/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:40:53.493696Z","caller":"traceutil/trace.go:171","msg":"trace[1248818831] range","detail":"{range_begin:/registry/rolebindings/kube-node-lease/; range_end:/registry/rolebindings/kube-node-lease0; response_count:0; response_revision:1084; }","duration":"455.811176ms","start":"2026-02-18T14:40:53.037871Z","end":"2026-02-18T14:40:53.493682Z","steps":["trace[1248818831] 'agreement among raft nodes before linearized reading' (duration: 451.862577ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:53.493868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T14:40:53.037857Z","time spent":"455.959807ms","remote":"127.0.0.1:54512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/rolebindings/kube-node-lease/\" range_end:\"/registry/rolebindings/kube-node-lease0\" limit:500 "} {"level":"warn","ts":"2026-02-18T14:40:53.684637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.360094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:40:53.684704Z","caller":"traceutil/trace.go:171","msg":"trace[1017072490] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1084; }","duration":"184.458725ms","start":"2026-02-18T14:40:53.50023Z","end":"2026-02-18T14:40:53.684689Z","steps":["trace[1017072490] 'range keys from in-memory index tree' (duration: 184.312654ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:53.684865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.199499ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T14:40:53.684963Z","caller":"traceutil/trace.go:171","msg":"trace[879917096] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"182.749558ms","start":"2026-02-18T14:40:53.502193Z","end":"2026-02-18T14:40:53.684943Z","steps":["trace[879917096] 'process raft request' (duration: 57.378968ms)","trace[879917096] 'compare' (duration: 124.961147ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:40:53.695481Z","caller":"traceutil/trace.go:171","msg":"trace[910530292] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"190.859781ms","start":"2026-02-18T14:40:53.50461Z","end":"2026-02-18T14:40:53.69547Z","steps":["trace[910530292] 'process raft request' (duration: 190.75972ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:40:54.345394Z","caller":"traceutil/trace.go:171","msg":"trace[329976351] linearizableReadLoop","detail":"{readStateIndex:1140; appliedIndex:1139; }","duration":"164.390168ms","start":"2026-02-18T14:40:54.180984Z","end":"2026-02-18T14:40:54.345374Z","steps":["trace[329976351] 'read index received' (duration: 164.192606ms)","trace[329976351] 'applied index is now lower than readState.Index' (duration: 196.492µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:40:54.34551Z","caller":"traceutil/trace.go:171","msg":"trace[288498552] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"171.233587ms","start":"2026-02-18T14:40:54.174266Z","end":"2026-02-18T14:40:54.3455Z","steps":["trace[288498552] 'process raft request' (duration: 170.922674ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:54.345874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.114016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/default/\" range_end:\"/registry/services/specs/default0\" limit:500 ","response":"range_response_count:1 size:704"} {"level":"info","ts":"2026-02-18T14:40:54.347984Z","caller":"traceutil/trace.go:171","msg":"trace[687098505] range","detail":"{range_begin:/registry/services/specs/default/; range_end:/registry/services/specs/default0; response_count:1; response_revision:1088; }","duration":"165.241897ms","start":"2026-02-18T14:40:54.182721Z","end":"2026-02-18T14:40:54.347963Z","steps":["trace[687098505] 'agreement among raft nodes before linearized reading' (duration: 163.079935ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:54.346149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.143135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/kube-node-lease/\" range_end:\"/registry/statefulsets/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:40:54.348585Z","caller":"traceutil/trace.go:171","msg":"trace[1481172634] range","detail":"{range_begin:/registry/statefulsets/kube-node-lease/; range_end:/registry/statefulsets/kube-node-lease0; response_count:0; response_revision:1088; }","duration":"167.61578ms","start":"2026-02-18T14:40:54.180952Z","end":"2026-02-18T14:40:54.348567Z","steps":["trace[1481172634] 'agreement among raft nodes before linearized reading' (duration: 165.116155ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:54.346218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.226957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/default/default\" ","response":"range_response_count:1 size:171"} {"level":"info","ts":"2026-02-18T14:40:54.348903Z","caller":"traceutil/trace.go:171","msg":"trace[251060480] range","detail":"{range_begin:/registry/serviceaccounts/default/default; range_end:; response_count:1; response_revision:1088; }","duration":"142.919143ms","start":"2026-02-18T14:40:54.205968Z","end":"2026-02-18T14:40:54.348887Z","steps":["trace[251060480] 'agreement among raft nodes before linearized reading' (duration: 140.220817ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:40:55.646807Z","caller":"traceutil/trace.go:171","msg":"trace[1740864193] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"110.397805ms","start":"2026-02-18T14:40:55.536394Z","end":"2026-02-18T14:40:55.646792Z","steps":["trace[1740864193] 'process raft request' (duration: 110.165553ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:40:55.889403Z","caller":"traceutil/trace.go:171","msg":"trace[741858642] linearizableReadLoop","detail":"{readStateIndex:1147; appliedIndex:1145; }","duration":"117.267942ms","start":"2026-02-18T14:40:55.772113Z","end":"2026-02-18T14:40:55.889381Z","steps":["trace[741858642] 'read index received' (duration: 88.769117ms)","trace[741858642] 'applied index is now lower than readState.Index' (duration: 28.497835ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:40:55.889914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.784228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kube-proxy\" ","response":"range_response_count:1 size:1948"} {"level":"info","ts":"2026-02-18T14:40:55.890256Z","caller":"traceutil/trace.go:171","msg":"trace[1213359550] range","detail":"{range_begin:/registry/configmaps/kube-system/kube-proxy; range_end:; response_count:1; response_revision:1095; }","duration":"118.165371ms","start":"2026-02-18T14:40:55.772082Z","end":"2026-02-18T14:40:55.890247Z","steps":["trace[1213359550] 'agreement among raft nodes before linearized reading' (duration: 117.620536ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T14:40:55.890815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.453274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T14:40:55.891053Z","caller":"traceutil/trace.go:171","msg":"trace[571037310] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1095; }","duration":"102.722628ms","start":"2026-02-18T14:40:55.788313Z","end":"2026-02-18T14:40:55.891036Z","steps":["trace[571037310] 'agreement among raft nodes before linearized reading' (duration: 102.373234ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:40:55.890092Z","caller":"traceutil/trace.go:171","msg":"trace[365936673] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"165.337353ms","start":"2026-02-18T14:40:55.724734Z","end":"2026-02-18T14:40:55.890071Z","steps":["trace[365936673] 'process raft request' (duration: 136.136001ms)","trace[365936673] 'compare' (duration: 28.078541ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T14:40:55.890128Z","caller":"traceutil/trace.go:171","msg":"trace[1873866429] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"148.188562ms","start":"2026-02-18T14:40:55.741931Z","end":"2026-02-18T14:40:55.89012Z","steps":["trace[1873866429] 'process raft request' (duration: 147.407463ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:40:56.868432Z","caller":"traceutil/trace.go:171","msg":"trace[1798506778] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"145.023696ms","start":"2026-02-18T14:40:56.723391Z","end":"2026-02-18T14:40:56.868415Z","steps":["trace[1798506778] 'process raft request' (duration: 144.853194ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:41:03.970411Z","caller":"traceutil/trace.go:171","msg":"trace[1063985978] transaction","detail":"{read_only:false; response_revision:1115; number_of_response:1; }","duration":"165.331853ms","start":"2026-02-18T14:41:03.805047Z","end":"2026-02-18T14:41:03.970379Z","steps":["trace[1063985978] 'process raft request' (duration: 163.87943ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T14:41:03.971329Z","caller":"traceutil/trace.go:171","msg":"trace[1399222732] linearizableReadLoop","detail":"{readStateIndex:1169; appliedIndex:1168; }","duration":"147.139796ms","start":"2026-02-18T14:41:03.823027Z","end":"2026-02-18T14:41:03.970166Z","steps":["trace[1399222732] 'read index received' (duration: 145.797834ms)","trace[1399222732] 'applied index is now lower than readState.Index' (duration: 1.340602ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T14:41:03.971696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.629782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ephemeral-volume-controller\" ","response":"range_response_count:1 size:220"} {"level":"info","ts":"2026-02-18T14:41:03.971913Z","caller":"traceutil/trace.go:171","msg":"trace[367276244] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ephemeral-volume-controller; range_end:; response_count:1; response_revision:1115; }","duration":"148.894475ms","start":"2026-02-18T14:41:03.823002Z","end":"2026-02-18T14:41:03.971897Z","steps":["trace[367276244] 'agreement among raft nodes before linearized reading' (duration: 148.577802ms)"],"step_count":1}