{"level":"warn","ts":"2026-02-10T21:28:35.186006Z","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-10T21:28:35.186112Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.169:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.169:2380","--initial-cluster=instance=https://199.204.45.169:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.169:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.169: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-10T21:28:35.186168Z","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-10T21:28:35.186192Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-02-10T21:28:35.18621Z","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-10T21:28:35.186888Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"]} {"level":"info","ts":"2026-02-10T21:28:35.186978Z","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://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.169: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-10T21:28:35.193743Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.545055ms"} {"level":"info","ts":"2026-02-10T21:28:35.215693Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1c917701ce165bac","cluster-id":"bfb5247022b87cb1"} {"level":"info","ts":"2026-02-10T21:28:35.215733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=()"} {"level":"info","ts":"2026-02-10T21:28:35.215759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 0"} {"level":"info","ts":"2026-02-10T21:28:35.215767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1c917701ce165bac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-10T21:28:35.215776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 1"} {"level":"info","ts":"2026-02-10T21:28:35.215802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"warn","ts":"2026-02-10T21:28:35.226127Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-10T21:28:35.22836Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-10T21:28:35.231436Z","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-10T21:28:35.233496Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1c917701ce165bac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-10T21:28:35.23493Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1c917701ce165bac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-10T21:28:35.249864Z","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-10T21:28:35.251704Z","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-10T21:28:35.252932Z","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-10T21:28:35.252234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"info","ts":"2026-02-10T21:28:35.253072Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","added-peer-id":"1c917701ce165bac","added-peer-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-02-10T21:28:35.252785Z","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-10T21:28:35.253223Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1c917701ce165bac","initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-10T21:28:35.253244Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-10T21:28:35.252807Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-02-10T21:28:35.253317Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-02-10T21:28:35.815962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac is starting a new election at term 1"} {"level":"info","ts":"2026-02-10T21:28:35.816002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became pre-candidate at term 1"} {"level":"info","ts":"2026-02-10T21:28:35.816018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgPreVoteResp from 1c917701ce165bac at term 1"} {"level":"info","ts":"2026-02-10T21:28:35.816028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became candidate at term 2"} {"level":"info","ts":"2026-02-10T21:28:35.816034Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgVoteResp from 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-02-10T21:28:35.816048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became leader at term 2"} {"level":"info","ts":"2026-02-10T21:28:35.816059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1c917701ce165bac elected leader 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-02-10T21:28:35.818223Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T21:28:35.819756Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1c917701ce165bac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.169:2379]}","request-path":"/0/members/1c917701ce165bac/attributes","cluster-id":"bfb5247022b87cb1","publish-timeout":"7s"} {"level":"info","ts":"2026-02-10T21:28:35.819914Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-10T21:28:35.820208Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-10T21:28:35.820408Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-10T21:28:35.820427Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-10T21:28:35.820463Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T21:28:35.820504Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T21:28:35.820522Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T21:28:35.82681Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-10T21:28:35.869835Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.169:2379"} {"level":"info","ts":"2026-02-10T21:28:50.833463Z","caller":"traceutil/trace.go:171","msg":"trace[744337147] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"240.352833ms","start":"2026-02-10T21:28:50.593089Z","end":"2026-02-10T21:28:50.833442Z","steps":["trace[744337147] 'process raft request' (duration: 239.905071ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:28:50.833828Z","caller":"traceutil/trace.go:171","msg":"trace[407056709] linearizableReadLoop","detail":"{readStateIndex:385; appliedIndex:384; }","duration":"228.909016ms","start":"2026-02-10T21:28:50.604908Z","end":"2026-02-10T21:28:50.833817Z","steps":["trace[407056709] 'read index received' (duration: 228.155386ms)","trace[407056709] 'applied index is now lower than readState.Index' (duration: 752.42µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:28:50.833997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.069451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4019"} {"level":"info","ts":"2026-02-10T21:28:50.834039Z","caller":"traceutil/trace.go:171","msg":"trace[983550869] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:372; }","duration":"229.143903ms","start":"2026-02-10T21:28:50.604884Z","end":"2026-02-10T21:28:50.834028Z","steps":["trace[983550869] 'agreement among raft nodes before linearized reading' (duration: 229.058521ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:28:50.836507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.097738ms","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-10T21:28:50.836565Z","caller":"traceutil/trace.go:171","msg":"trace[1316339775] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:373; }","duration":"155.229642ms","start":"2026-02-10T21:28:50.681321Z","end":"2026-02-10T21:28:50.836551Z","steps":["trace[1316339775] 'agreement among raft nodes before linearized reading' (duration: 155.072127ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:29:07.148508Z","caller":"traceutil/trace.go:171","msg":"trace[207856327] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"246.770315ms","start":"2026-02-10T21:29:06.901724Z","end":"2026-02-10T21:29:07.148494Z","steps":["trace[207856327] 'process raft request' (duration: 246.58222ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:07.772535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.443536ms","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-10T21:29:07.772624Z","caller":"traceutil/trace.go:171","msg":"trace[1826127517] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:477; }","duration":"108.543029ms","start":"2026-02-10T21:29:07.664049Z","end":"2026-02-10T21:29:07.772592Z","steps":["trace[1826127517] 'range keys from in-memory index tree' (duration: 108.356025ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:29:07.900484Z","caller":"traceutil/trace.go:171","msg":"trace[67978887] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"118.775954ms","start":"2026-02-10T21:29:07.781692Z","end":"2026-02-10T21:29:07.900468Z","steps":["trace[67978887] 'process raft request' (duration: 118.692732ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:29:08.154725Z","caller":"traceutil/trace.go:171","msg":"trace[371853967] linearizableReadLoop","detail":"{readStateIndex:497; appliedIndex:496; }","duration":"367.517371ms","start":"2026-02-10T21:29:07.787192Z","end":"2026-02-10T21:29:08.154709Z","steps":["trace[371853967] 'read index received' (duration: 113.584745ms)","trace[371853967] 'applied index is now lower than readState.Index' (duration: 253.932016ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:29:08.154911Z","caller":"traceutil/trace.go:171","msg":"trace[1048579957] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"371.684973ms","start":"2026-02-10T21:29:07.783217Z","end":"2026-02-10T21:29:08.154902Z","steps":["trace[1048579957] 'process raft request' (duration: 300.502984ms)","trace[1048579957] 'compare' (duration: 70.917952ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:29:08.155138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.931852ms","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-10T21:29:08.155186Z","caller":"traceutil/trace.go:171","msg":"trace[683570486] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:479; }","duration":"368.001454ms","start":"2026-02-10T21:29:07.78717Z","end":"2026-02-10T21:29:08.155171Z","steps":["trace[683570486] 'agreement among raft nodes before linearized reading' (duration: 367.924282ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:08.155212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:29:07.787164Z","time spent":"368.039565ms","remote":"127.0.0.1:37960","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-10T21:29:08.155254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:29:07.783205Z","time spent":"371.723303ms","remote":"127.0.0.1:37960","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-10T21:29:09.468907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.907948ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T21:29:09.469006Z","caller":"traceutil/trace.go:171","msg":"trace[1752015102] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"268.691873ms","start":"2026-02-10T21:29:09.200287Z","end":"2026-02-10T21:29:09.468978Z","steps":["trace[1752015102] 'process raft request' (duration: 121.458836ms)","trace[1752015102] 'compare' (duration: 146.647661ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:29:09.883817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.561681ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T21:29:09.883908Z","caller":"traceutil/trace.go:171","msg":"trace[1067728961] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:482; }","duration":"208.669273ms","start":"2026-02-10T21:29:09.675226Z","end":"2026-02-10T21:29:09.883895Z","steps":["trace[1067728961] 'range keys from in-memory index tree' (duration: 208.54803ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:09.8844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.357451ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T21:29:09.884439Z","caller":"traceutil/trace.go:171","msg":"trace[1548221573] linearizableReadLoop","detail":"{readStateIndex:502; appliedIndex:501; }","duration":"413.420163ms","start":"2026-02-10T21:29:09.471012Z","end":"2026-02-10T21:29:09.884432Z","steps":["trace[1548221573] 'read index received' (duration: 109.921957ms)","trace[1548221573] 'applied index is now lower than readState.Index' (duration: 303.497586ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:29:09.884492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.478574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-02-10T21:29:09.884508Z","caller":"traceutil/trace.go:171","msg":"trace[616407265] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:483; }","duration":"413.524355ms","start":"2026-02-10T21:29:09.470978Z","end":"2026-02-10T21:29:09.884503Z","steps":["trace[616407265] 'agreement among raft nodes before linearized reading' (duration: 413.486704ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:09.884532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:29:09.470963Z","time spent":"413.563856ms","remote":"127.0.0.1:37852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":445,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"info","ts":"2026-02-10T21:29:09.884678Z","caller":"traceutil/trace.go:171","msg":"trace[337714784] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"682.373232ms","start":"2026-02-10T21:29:09.202298Z","end":"2026-02-10T21:29:09.884671Z","steps":["trace[337714784] 'process raft request' (duration: 378.696792ms)","trace[337714784] 'compare' (duration: 303.245299ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:29:09.884713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:29:09.20229Z","time spent":"682.404653ms","remote":"127.0.0.1:37960","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-10T21:29:11.246925Z","caller":"traceutil/trace.go:171","msg":"trace[1988029861] linearizableReadLoop","detail":"{readStateIndex:506; appliedIndex:505; }","duration":"120.002166ms","start":"2026-02-10T21:29:11.126898Z","end":"2026-02-10T21:29:11.2469Z","steps":["trace[1988029861] 'read index received' (duration: 119.807691ms)","trace[1988029861] 'applied index is now lower than readState.Index' (duration: 193.315µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:29:11.247081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.14612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T21:29:11.247123Z","caller":"traceutil/trace.go:171","msg":"trace[1076515688] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:487; }","duration":"120.261233ms","start":"2026-02-10T21:29:11.126852Z","end":"2026-02-10T21:29:11.247113Z","steps":["trace[1076515688] 'agreement among raft nodes before linearized reading' (duration: 120.14015ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:29:11.247473Z","caller":"traceutil/trace.go:171","msg":"trace[880648305] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"179.565194ms","start":"2026-02-10T21:29:11.067895Z","end":"2026-02-10T21:29:11.24746Z","steps":["trace[880648305] 'process raft request' (duration: 178.870615ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:29:14.361139Z","caller":"traceutil/trace.go:171","msg":"trace[408336149] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"628.830857ms","start":"2026-02-10T21:29:13.732278Z","end":"2026-02-10T21:29:14.361109Z","steps":["trace[408336149] 'process raft request' (duration: 628.672333ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:14.361318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:29:13.732262Z","time spent":"628.947209ms","remote":"127.0.0.1:37870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T21:29:14.361675Z","caller":"traceutil/trace.go:171","msg":"trace[1548369375] linearizableReadLoop","detail":"{readStateIndex:514; appliedIndex:514; }","duration":"466.27837ms","start":"2026-02-10T21:29:13.895386Z","end":"2026-02-10T21:29:14.361665Z","steps":["trace[1548369375] 'read index received' (duration: 466.271349ms)","trace[1548369375] 'applied index is now lower than readState.Index' (duration: 5.891µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:29:14.361821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.430614ms","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-10T21:29:14.36184Z","caller":"traceutil/trace.go:171","msg":"trace[1059052196] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:495; }","duration":"466.478154ms","start":"2026-02-10T21:29:13.895356Z","end":"2026-02-10T21:29:14.361834Z","steps":["trace[1059052196] 'agreement among raft nodes before linearized reading' (duration: 466.354851ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:14.361856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:29:13.895342Z","time spent":"466.510766ms","remote":"127.0.0.1:37960","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-10T21:29:14.710558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.520589ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-10T21:29:14.71074Z","caller":"traceutil/trace.go:171","msg":"trace[63511329] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"345.354858ms","start":"2026-02-10T21:29:14.365372Z","end":"2026-02-10T21:29:14.710727Z","steps":["trace[63511329] 'process raft request' (duration: 345.270645ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:14.710819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:29:14.365344Z","time spent":"345.42734ms","remote":"127.0.0.1:37960","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-10T21:29:14.711003Z","caller":"traceutil/trace.go:171","msg":"trace[620162029] linearizableReadLoop","detail":"{readStateIndex:515; appliedIndex:514; }","duration":"349.303904ms","start":"2026-02-10T21:29:14.361693Z","end":"2026-02-10T21:29:14.710997Z","steps":["trace[620162029] 'read index received' (duration: 246.357654ms)","trace[620162029] 'applied index is now lower than readState.Index' (duration: 102.94561ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:29:14.711099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.300562ms","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-10T21:29:14.711121Z","caller":"traceutil/trace.go:171","msg":"trace[727223518] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:496; }","duration":"713.360423ms","start":"2026-02-10T21:29:13.997755Z","end":"2026-02-10T21:29:14.711115Z","steps":["trace[727223518] 'agreement among raft nodes before linearized reading' (duration: 713.269071ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:14.711144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:29:13.997736Z","time spent":"713.403434ms","remote":"127.0.0.1:37960","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-10T21:29:14.711317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.322469ms","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-10T21:29:14.711338Z","caller":"traceutil/trace.go:171","msg":"trace[1795215445] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:496; }","duration":"526.36746ms","start":"2026-02-10T21:29:14.184966Z","end":"2026-02-10T21:29:14.711334Z","steps":["trace[1795215445] 'agreement among raft nodes before linearized reading' (duration: 526.316769ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:14.711355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:29:14.18496Z","time spent":"526.39131ms","remote":"127.0.0.1:37960","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-10T21:29:14.711454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.778135ms","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-10T21:29:14.711469Z","caller":"traceutil/trace.go:171","msg":"trace[581882093] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:496; }","duration":"528.821085ms","start":"2026-02-10T21:29:14.182643Z","end":"2026-02-10T21:29:14.711464Z","steps":["trace[581882093] 'agreement among raft nodes before linearized reading' (duration: 528.769014ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:14.711485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:29:14.182629Z","time spent":"528.851287ms","remote":"127.0.0.1:37960","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":"info","ts":"2026-02-10T21:29:15.863407Z","caller":"traceutil/trace.go:171","msg":"trace[1346977030] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"124.636531ms","start":"2026-02-10T21:29:15.738749Z","end":"2026-02-10T21:29:15.863385Z","steps":["trace[1346977030] 'process raft request' (duration: 124.521788ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:29:15.869357Z","caller":"traceutil/trace.go:171","msg":"trace[218400871] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"123.937863ms","start":"2026-02-10T21:29:15.745404Z","end":"2026-02-10T21:29:15.869341Z","steps":["trace[218400871] 'process raft request' (duration: 123.83921ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:29:24.634632Z","caller":"traceutil/trace.go:171","msg":"trace[1120827263] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"122.390231ms","start":"2026-02-10T21:29:24.512226Z","end":"2026-02-10T21:29:24.634616Z","steps":["trace[1120827263] 'process raft request' (duration: 122.280118ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:29:28.204342Z","caller":"traceutil/trace.go:171","msg":"trace[736809916] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"167.296795ms","start":"2026-02-10T21:29:28.037021Z","end":"2026-02-10T21:29:28.204318Z","steps":["trace[736809916] 'process raft request' (duration: 166.878263ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:29.049885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.059435ms","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-10T21:29:29.049959Z","caller":"traceutil/trace.go:171","msg":"trace[1589415799] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:627; }","duration":"265.160368ms","start":"2026-02-10T21:29:28.784779Z","end":"2026-02-10T21:29:29.049939Z","steps":["trace[1589415799] 'range keys from in-memory index tree' (duration: 264.964993ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:29:29.050249Z","caller":"traceutil/trace.go:171","msg":"trace[462839662] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"239.392347ms","start":"2026-02-10T21:29:28.810849Z","end":"2026-02-10T21:29:29.050242Z","steps":["trace[462839662] 'read index received' (duration: 208.474448ms)","trace[462839662] 'applied index is now lower than readState.Index' (duration: 30.917399ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:29:29.050271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.896912ms","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-10T21:29:29.050328Z","caller":"traceutil/trace.go:171","msg":"trace[615589569] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:627; }","duration":"251.961584ms","start":"2026-02-10T21:29:28.798354Z","end":"2026-02-10T21:29:29.050315Z","steps":["trace[615589569] 'range keys from in-memory index tree' (duration: 251.804379ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:29:29.050389Z","caller":"traceutil/trace.go:171","msg":"trace[1381597904] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"242.894091ms","start":"2026-02-10T21:29:28.807486Z","end":"2026-02-10T21:29:29.05038Z","steps":["trace[1381597904] 'process raft request' (duration: 211.88659ms)","trace[1381597904] 'compare' (duration: 30.396135ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:29:29.050464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.612453ms","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-10T21:29:29.050476Z","caller":"traceutil/trace.go:171","msg":"trace[570968078] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:628; }","duration":"239.648334ms","start":"2026-02-10T21:29:28.810824Z","end":"2026-02-10T21:29:29.050472Z","steps":["trace[570968078] 'agreement among raft nodes before linearized reading' (duration: 239.608063ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:29.050532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.628504ms","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-10T21:29:29.050542Z","caller":"traceutil/trace.go:171","msg":"trace[2134738820] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:628; }","duration":"239.652154ms","start":"2026-02-10T21:29:28.810887Z","end":"2026-02-10T21:29:29.050539Z","steps":["trace[2134738820] 'agreement among raft nodes before linearized reading' (duration: 239.622373ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:29.769662Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605826592751260771,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-10T21:29:29.773125Z","caller":"traceutil/trace.go:171","msg":"trace[1117113352] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"718.108559ms","start":"2026-02-10T21:29:29.055Z","end":"2026-02-10T21:29:29.773109Z","steps":["trace[1117113352] 'process raft request' (duration: 718.004286ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:29.773212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:29:29.054988Z","time spent":"718.16882ms","remote":"127.0.0.1:37960","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-10T21:29:29.904339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:29:29.055316Z","time spent":"849.019088ms","remote":"127.0.0.1:37708","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-10T21:29:29.904501Z","caller":"traceutil/trace.go:171","msg":"trace[2083592531] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:652; }","duration":"635.259158ms","start":"2026-02-10T21:29:29.269218Z","end":"2026-02-10T21:29:29.904477Z","steps":["trace[2083592531] 'read index received' (duration: 504.237876ms)","trace[2083592531] 'applied index is now lower than readState.Index' (duration: 131.020152ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:29:29.904705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.461463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-02-10T21:29:29.904754Z","caller":"traceutil/trace.go:171","msg":"trace[1693849660] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:632; }","duration":"635.557586ms","start":"2026-02-10T21:29:29.269173Z","end":"2026-02-10T21:29:29.904731Z","steps":["trace[1693849660] 'agreement among raft nodes before linearized reading' (duration: 635.391731ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:29.904785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:29:29.269156Z","time spent":"635.621108ms","remote":"127.0.0.1:37960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-10T21:29:29.904912Z","caller":"traceutil/trace.go:171","msg":"trace[626555660] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"849.798739ms","start":"2026-02-10T21:29:29.055098Z","end":"2026-02-10T21:29:29.904896Z","steps":["trace[626555660] 'process raft request' (duration: 836.449821ms)","trace[626555660] 'compare' (duration: 12.587848ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:29:29.904999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:29:29.055091Z","time spent":"849.853ms","remote":"127.0.0.1:37960","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-10T21:29:29.905028Z","caller":"traceutil/trace.go:171","msg":"trace[551891238] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"849.641144ms","start":"2026-02-10T21:29:29.055376Z","end":"2026-02-10T21:29:29.905017Z","steps":["trace[551891238] 'process raft request' (duration: 848.926755ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:29:29.905088Z","caller":"traceutil/trace.go:171","msg":"trace[1407128995] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"849.951423ms","start":"2026-02-10T21:29:29.055131Z","end":"2026-02-10T21:29:29.905082Z","steps":["trace[1407128995] 'process raft request' (duration: 849.08499ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:29.905115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:29:29.055128Z","time spent":"849.973374ms","remote":"127.0.0.1:37960","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-10T21:29:29.905112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:29:29.055372Z","time spent":"849.682335ms","remote":"127.0.0.1:37960","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-10T21:29:34.006512Z","caller":"traceutil/trace.go:171","msg":"trace[1626738726] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"219.641627ms","start":"2026-02-10T21:29:33.786849Z","end":"2026-02-10T21:29:34.006491Z","steps":["trace[1626738726] 'process raft request' (duration: 219.287088ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:29:38.24974Z","caller":"traceutil/trace.go:171","msg":"trace[543452708] linearizableReadLoop","detail":"{readStateIndex:715; appliedIndex:714; }","duration":"218.866987ms","start":"2026-02-10T21:29:38.030822Z","end":"2026-02-10T21:29:38.249689Z","steps":["trace[543452708] 'read index received' (duration: 218.58751ms)","trace[543452708] 'applied index is now lower than readState.Index' (duration: 278.467µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:29:38.249925Z","caller":"traceutil/trace.go:171","msg":"trace[159019893] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"229.193183ms","start":"2026-02-10T21:29:38.020719Z","end":"2026-02-10T21:29:38.249912Z","steps":["trace[159019893] 'process raft request' (duration: 228.772592ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:38.250219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.800861ms","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-10T21:29:38.250299Z","caller":"traceutil/trace.go:171","msg":"trace[365145514] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:690; }","duration":"216.913404ms","start":"2026-02-10T21:29:38.033364Z","end":"2026-02-10T21:29:38.250278Z","steps":["trace[365145514] 'agreement among raft nodes before linearized reading' (duration: 216.712239ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:38.25057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.593133ms","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-10T21:29:38.2506Z","caller":"traceutil/trace.go:171","msg":"trace[1519965618] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:690; }","duration":"214.629373ms","start":"2026-02-10T21:29:38.035961Z","end":"2026-02-10T21:29:38.25059Z","steps":["trace[1519965618] 'agreement among raft nodes before linearized reading' (duration: 214.544981ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:38.250606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.170147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-02-10T21:29:38.25067Z","caller":"traceutil/trace.go:171","msg":"trace[1644621504] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:690; }","duration":"212.27182ms","start":"2026-02-10T21:29:38.038387Z","end":"2026-02-10T21:29:38.250658Z","steps":["trace[1644621504] 'agreement among raft nodes before linearized reading' (duration: 212.059135ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:38.250844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.845427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T21:29:38.250875Z","caller":"traceutil/trace.go:171","msg":"trace[1099632085] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:690; }","duration":"124.893218ms","start":"2026-02-10T21:29:38.125972Z","end":"2026-02-10T21:29:38.250865Z","steps":["trace[1099632085] 'agreement among raft nodes before linearized reading' (duration: 124.849147ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:38.251056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.230024ms","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-10T21:29:38.251087Z","caller":"traceutil/trace.go:171","msg":"trace[1550646020] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:690; }","duration":"220.260415ms","start":"2026-02-10T21:29:38.030818Z","end":"2026-02-10T21:29:38.251079Z","steps":["trace[1550646020] 'agreement among raft nodes before linearized reading' (duration: 220.177832ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:29:38.393121Z","caller":"traceutil/trace.go:171","msg":"trace[969305237] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"137.019333ms","start":"2026-02-10T21:29:38.256086Z","end":"2026-02-10T21:29:38.393105Z","steps":["trace[969305237] 'process raft request' (duration: 121.592389ms)","trace[969305237] 'compare' (duration: 15.361962ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:29:38.412469Z","caller":"traceutil/trace.go:171","msg":"trace[1474144347] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"153.292799ms","start":"2026-02-10T21:29:38.259169Z","end":"2026-02-10T21:29:38.412462Z","steps":["trace[1474144347] 'process raft request' (duration: 153.259078ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:29:38.412596Z","caller":"traceutil/trace.go:171","msg":"trace[856388593] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"154.07903ms","start":"2026-02-10T21:29:38.258511Z","end":"2026-02-10T21:29:38.41259Z","steps":["trace[856388593] 'process raft request' (duration: 153.868585ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:29:38.4126Z","caller":"traceutil/trace.go:171","msg":"trace[1791981094] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"152.039656ms","start":"2026-02-10T21:29:38.260539Z","end":"2026-02-10T21:29:38.412579Z","steps":["trace[1791981094] 'process raft request' (duration: 151.905722ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:55.146607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.573062ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-10T21:29:55.147988Z","caller":"traceutil/trace.go:171","msg":"trace[1792260616] linearizableReadLoop","detail":"{readStateIndex:771; appliedIndex:769; }","duration":"709.579714ms","start":"2026-02-10T21:29:54.438359Z","end":"2026-02-10T21:29:55.147939Z","steps":["trace[1792260616] 'read index received' (duration: 384.604075ms)","trace[1792260616] 'applied index is now lower than readState.Index' (duration: 324.974839ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:29:55.148035Z","caller":"traceutil/trace.go:171","msg":"trace[1718944374] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"816.941828ms","start":"2026-02-10T21:29:54.331077Z","end":"2026-02-10T21:29:55.148019Z","steps":["trace[1718944374] 'process raft request' (duration: 815.622943ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:55.14814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:29:54.33106Z","time spent":"817.01275ms","remote":"127.0.0.1:37960","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-10T21:29:55.805115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.325320896s","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-10T21:29:55.805188Z","caller":"traceutil/trace.go:171","msg":"trace[755218996] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:742; }","duration":"1.325414689s","start":"2026-02-10T21:29:54.479752Z","end":"2026-02-10T21:29:55.805167Z","steps":["trace[755218996] 'agreement among raft nodes before linearized reading' (duration: 668.32381ms)","trace[755218996] 'range keys from in-memory index tree' (duration: 656.922344ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:29:55.805224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:29:54.479747Z","time spent":"1.32546816s","remote":"127.0.0.1:37960","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-10T21:29:55.805613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.34489302s","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-10T21:29:55.805648Z","caller":"traceutil/trace.go:171","msg":"trace[1062442124] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:742; }","duration":"1.344952961s","start":"2026-02-10T21:29:54.460684Z","end":"2026-02-10T21:29:55.805637Z","steps":["trace[1062442124] 'agreement among raft nodes before linearized reading' (duration: 687.375169ms)","trace[1062442124] 'range keys from in-memory index tree' (duration: 657.49668ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:29:55.805674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:29:54.460672Z","time spent":"1.344995203s","remote":"127.0.0.1:37960","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-10T21:29:55.805858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.367496225s","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-10T21:29:55.805888Z","caller":"traceutil/trace.go:171","msg":"trace[1848775864] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:742; }","duration":"1.367563627s","start":"2026-02-10T21:29:54.438315Z","end":"2026-02-10T21:29:55.805879Z","steps":["trace[1848775864] 'agreement among raft nodes before linearized reading' (duration: 709.730728ms)","trace[1848775864] 'range keys from in-memory index tree' (duration: 657.747937ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:29:55.805914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:29:54.438298Z","time spent":"1.367609089s","remote":"127.0.0.1:37960","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-10T21:29:55.806248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.319350356s","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-10T21:29:55.80628Z","caller":"traceutil/trace.go:171","msg":"trace[1227571598] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:742; }","duration":"1.319391097s","start":"2026-02-10T21:29:54.486879Z","end":"2026-02-10T21:29:55.80627Z","steps":["trace[1227571598] 'agreement among raft nodes before linearized reading' (duration: 661.190249ms)","trace[1227571598] 'range keys from in-memory index tree' (duration: 658.128266ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:29:55.806305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:29:54.486875Z","time spent":"1.319423768s","remote":"127.0.0.1:37960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-10T21:29:55.99108Z","caller":"traceutil/trace.go:171","msg":"trace[151614325] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"175.117938ms","start":"2026-02-10T21:29:55.815935Z","end":"2026-02-10T21:29:55.991053Z","steps":["trace[151614325] 'process raft request' (duration: 174.916872ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:29:56.025007Z","caller":"traceutil/trace.go:171","msg":"trace[384290342] linearizableReadLoop","detail":"{readStateIndex:775; appliedIndex:771; }","duration":"104.497897ms","start":"2026-02-10T21:29:55.920491Z","end":"2026-02-10T21:29:56.024989Z","steps":["trace[384290342] 'read index received' (duration: 70.541868ms)","trace[384290342] 'applied index is now lower than readState.Index' (duration: 33.955339ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:29:56.025125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.61916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-10T21:29:56.025147Z","caller":"traceutil/trace.go:171","msg":"trace[2103222075] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:746; }","duration":"104.705563ms","start":"2026-02-10T21:29:55.920434Z","end":"2026-02-10T21:29:56.02514Z","steps":["trace[2103222075] 'agreement among raft nodes before linearized reading' (duration: 104.61331ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:29:56.025309Z","caller":"traceutil/trace.go:171","msg":"trace[1985237888] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"208.586023ms","start":"2026-02-10T21:29:55.816716Z","end":"2026-02-10T21:29:56.025302Z","steps":["trace[1985237888] 'process raft request' (duration: 208.220703ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:29:56.0254Z","caller":"traceutil/trace.go:171","msg":"trace[1935499610] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"207.125125ms","start":"2026-02-10T21:29:55.818269Z","end":"2026-02-10T21:29:56.025394Z","steps":["trace[1935499610] 'process raft request' (duration: 206.691253ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:29:56.025017Z","caller":"traceutil/trace.go:171","msg":"trace[1722215084] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"208.317046ms","start":"2026-02-10T21:29:55.816684Z","end":"2026-02-10T21:29:56.025001Z","steps":["trace[1722215084] 'process raft request' (duration: 206.996441ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:29:58.139223Z","caller":"traceutil/trace.go:171","msg":"trace[709266964] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"105.01222ms","start":"2026-02-10T21:29:58.034189Z","end":"2026-02-10T21:29:58.139202Z","steps":["trace[709266964] 'process raft request' (duration: 104.970539ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:29:58.139251Z","caller":"traceutil/trace.go:171","msg":"trace[276485167] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"106.87683ms","start":"2026-02-10T21:29:58.032346Z","end":"2026-02-10T21:29:58.139223Z","steps":["trace[276485167] 'process raft request' (duration: 90.175773ms)","trace[276485167] 'compare' (duration: 16.547813ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:29:58.139488Z","caller":"traceutil/trace.go:171","msg":"trace[2057170317] linearizableReadLoop","detail":"{readStateIndex:778; appliedIndex:777; }","duration":"106.827438ms","start":"2026-02-10T21:29:58.032647Z","end":"2026-02-10T21:29:58.139475Z","steps":["trace[2057170317] 'read index received' (duration: 90.051999ms)","trace[2057170317] 'applied index is now lower than readState.Index' (duration: 16.774909ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:29:58.139622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.944262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-10T21:29:58.139648Z","caller":"traceutil/trace.go:171","msg":"trace[1637019463] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:750; }","duration":"107.037664ms","start":"2026-02-10T21:29:58.032599Z","end":"2026-02-10T21:29:58.139637Z","steps":["trace[1637019463] 'agreement among raft nodes before linearized reading' (duration: 106.943382ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:29:58.139854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.01633ms","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-10T21:29:58.139869Z","caller":"traceutil/trace.go:171","msg":"trace[1304170577] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:750; }","duration":"105.043841ms","start":"2026-02-10T21:29:58.034821Z","end":"2026-02-10T21:29:58.139865Z","steps":["trace[1304170577] 'agreement among raft nodes before linearized reading' (duration: 104.977159ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:30:09.427293Z","caller":"traceutil/trace.go:171","msg":"trace[793205242] transaction","detail":"{read_only:false; response_revision:833; number_of_response:1; }","duration":"149.994645ms","start":"2026-02-10T21:30:09.277284Z","end":"2026-02-10T21:30:09.427279Z","steps":["trace[793205242] 'process raft request' (duration: 149.908753ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:30:10.240056Z","caller":"traceutil/trace.go:171","msg":"trace[761981266] transaction","detail":"{read_only:false; response_revision:834; number_of_response:1; }","duration":"135.22537ms","start":"2026-02-10T21:30:10.104803Z","end":"2026-02-10T21:30:10.240028Z","steps":["trace[761981266] 'process raft request' (duration: 135.132748ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:30:11.234726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.1614ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T21:30:11.234783Z","caller":"traceutil/trace.go:171","msg":"trace[1254587182] linearizableReadLoop","detail":"{readStateIndex:869; appliedIndex:868; }","duration":"1.111696109s","start":"2026-02-10T21:30:10.123078Z","end":"2026-02-10T21:30:11.234774Z","steps":["trace[1254587182] 'read index received' (duration: 117.386023ms)","trace[1254587182] 'applied index is now lower than readState.Index' (duration: 994.309546ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:30:11.234897Z","caller":"traceutil/trace.go:171","msg":"trace[1825163991] transaction","detail":"{read_only:false; response_revision:835; number_of_response:1; }","duration":"1.120185486s","start":"2026-02-10T21:30:10.114706Z","end":"2026-02-10T21:30:11.234891Z","steps":["trace[1825163991] 'process raft request' (duration: 669.81084ms)","trace[1825163991] 'compare' (duration: 450.004476ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:30:11.234926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:30:10.114699Z","time spent":"1.120212346s","remote":"127.0.0.1:37960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T21:30:11.235018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.111939955s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T21:30:11.23503Z","caller":"traceutil/trace.go:171","msg":"trace[1508163759] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:835; }","duration":"1.111967536s","start":"2026-02-10T21:30:10.123059Z","end":"2026-02-10T21:30:11.235026Z","steps":["trace[1508163759] 'agreement among raft nodes before linearized reading' (duration: 1.111944775s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:30:11.235043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:30:10.123051Z","time spent":"1.111988856s","remote":"127.0.0.1:37654","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-10T21:30:11.235144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.02807272s","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-10T21:30:11.235156Z","caller":"traceutil/trace.go:171","msg":"trace[2106830424] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:835; }","duration":"1.02808471s","start":"2026-02-10T21:30:10.207067Z","end":"2026-02-10T21:30:11.235152Z","steps":["trace[2106830424] 'agreement among raft nodes before linearized reading' (duration: 1.028032819s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:30:11.235178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:30:10.207019Z","time spent":"1.028147272s","remote":"127.0.0.1:37960","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-10T21:30:11.235284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"984.481703ms","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-10T21:30:11.235296Z","caller":"traceutil/trace.go:171","msg":"trace[367501383] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:835; }","duration":"984.503544ms","start":"2026-02-10T21:30:10.250789Z","end":"2026-02-10T21:30:11.235292Z","steps":["trace[367501383] 'agreement among raft nodes before linearized reading' (duration: 984.466443ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:30:11.235307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:30:10.250784Z","time spent":"984.520534ms","remote":"127.0.0.1:37960","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-10T21:30:11.235382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"986.270931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-02-10T21:30:11.235394Z","caller":"traceutil/trace.go:171","msg":"trace[1012494309] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:835; }","duration":"986.304321ms","start":"2026-02-10T21:30:10.249086Z","end":"2026-02-10T21:30:11.23539Z","steps":["trace[1012494309] 'agreement among raft nodes before linearized reading' (duration: 986.27108ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:30:11.235404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:30:10.249075Z","time spent":"986.326623ms","remote":"127.0.0.1:37960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-10T21:30:12.41498Z","caller":"traceutil/trace.go:171","msg":"trace[808772489] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"166.746074ms","start":"2026-02-10T21:30:12.24822Z","end":"2026-02-10T21:30:12.414966Z","steps":["trace[808772489] 'process raft request' (duration: 166.670042ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:30:14.521365Z","caller":"traceutil/trace.go:171","msg":"trace[342321561] linearizableReadLoop","detail":"{readStateIndex:880; appliedIndex:879; }","duration":"101.775035ms","start":"2026-02-10T21:30:14.419567Z","end":"2026-02-10T21:30:14.521342Z","steps":["trace[342321561] 'read index received' (duration: 42.55718ms)","trace[342321561] 'applied index is now lower than readState.Index' (duration: 59.216425ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:30:14.52155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.96019ms","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-10T21:30:14.52158Z","caller":"traceutil/trace.go:171","msg":"trace[604601880] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:845; }","duration":"102.030271ms","start":"2026-02-10T21:30:14.419541Z","end":"2026-02-10T21:30:14.521571Z","steps":["trace[604601880] 'agreement among raft nodes before linearized reading' (duration: 101.882747ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:30:21.516653Z","caller":"traceutil/trace.go:171","msg":"trace[1729754385] linearizableReadLoop","detail":"{readStateIndex:899; appliedIndex:898; }","duration":"165.138071ms","start":"2026-02-10T21:30:21.351498Z","end":"2026-02-10T21:30:21.516636Z","steps":["trace[1729754385] 'read index received' (duration: 165.054889ms)","trace[1729754385] 'applied index is now lower than readState.Index' (duration: 82.472µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:30:21.516737Z","caller":"traceutil/trace.go:171","msg":"trace[1899525138] transaction","detail":"{read_only:false; response_revision:863; number_of_response:1; }","duration":"176.013041ms","start":"2026-02-10T21:30:21.340718Z","end":"2026-02-10T21:30:21.516731Z","steps":["trace[1899525138] 'process raft request' (duration: 175.820086ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:30:21.516941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.407596ms","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-10T21:30:21.517004Z","caller":"traceutil/trace.go:171","msg":"trace[803801545] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:863; }","duration":"156.485139ms","start":"2026-02-10T21:30:21.360503Z","end":"2026-02-10T21:30:21.516988Z","steps":["trace[803801545] 'agreement among raft nodes before linearized reading' (duration: 156.337515ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:30:21.517095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.578403ms","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-10T21:30:21.517121Z","caller":"traceutil/trace.go:171","msg":"trace[2031415650] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:863; }","duration":"165.642784ms","start":"2026-02-10T21:30:21.351471Z","end":"2026-02-10T21:30:21.517113Z","steps":["trace[2031415650] 'agreement among raft nodes before linearized reading' (duration: 165.538311ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:30:21.724842Z","caller":"traceutil/trace.go:171","msg":"trace[130281330] transaction","detail":"{read_only:false; response_revision:864; number_of_response:1; }","duration":"203.478886ms","start":"2026-02-10T21:30:21.521346Z","end":"2026-02-10T21:30:21.724825Z","steps":["trace[130281330] 'process raft request' (duration: 126.679341ms)","trace[130281330] 'compare' (duration: 76.720343ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:30:21.7264Z","caller":"traceutil/trace.go:171","msg":"trace[757213783] transaction","detail":"{read_only:false; response_revision:867; number_of_response:1; }","duration":"180.370748ms","start":"2026-02-10T21:30:21.546023Z","end":"2026-02-10T21:30:21.726394Z","steps":["trace[757213783] 'process raft request' (duration: 180.343868ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:30:21.726561Z","caller":"traceutil/trace.go:171","msg":"trace[1015900863] transaction","detail":"{read_only:false; response_revision:865; number_of_response:1; }","duration":"204.149365ms","start":"2026-02-10T21:30:21.522405Z","end":"2026-02-10T21:30:21.726555Z","steps":["trace[1015900863] 'process raft request' (duration: 203.904348ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:30:21.726623Z","caller":"traceutil/trace.go:171","msg":"trace[35239583] transaction","detail":"{read_only:false; response_revision:866; number_of_response:1; }","duration":"198.618647ms","start":"2026-02-10T21:30:21.528Z","end":"2026-02-10T21:30:21.726619Z","steps":["trace[35239583] 'process raft request' (duration: 198.342959ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:30:25.720325Z","caller":"traceutil/trace.go:171","msg":"trace[2009829022] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"109.860731ms","start":"2026-02-10T21:30:25.610448Z","end":"2026-02-10T21:30:25.720308Z","steps":["trace[2009829022] 'process raft request' (duration: 109.742148ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:30:25.989553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.23051ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T21:30:25.989633Z","caller":"traceutil/trace.go:171","msg":"trace[751537076] linearizableReadLoop","detail":"{readStateIndex:913; appliedIndex:912; }","duration":"246.901479ms","start":"2026-02-10T21:30:25.742718Z","end":"2026-02-10T21:30:25.989619Z","steps":["trace[751537076] 'read index received' (duration: 136.580936ms)","trace[751537076] 'applied index is now lower than readState.Index' (duration: 110.319593ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:30:25.989869Z","caller":"traceutil/trace.go:171","msg":"trace[1947165481] transaction","detail":"{read_only:false; response_revision:876; number_of_response:1; }","duration":"254.957154ms","start":"2026-02-10T21:30:25.734899Z","end":"2026-02-10T21:30:25.989856Z","steps":["trace[1947165481] 'process raft request' (duration: 144.358714ms)","trace[1947165481] 'compare' (duration: 110.090377ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:30:25.990078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.354341ms","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-10T21:30:25.990107Z","caller":"traceutil/trace.go:171","msg":"trace[1829919233] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:876; }","duration":"247.398542ms","start":"2026-02-10T21:30:25.7427Z","end":"2026-02-10T21:30:25.990099Z","steps":["trace[1829919233] 'agreement among raft nodes before linearized reading' (duration: 247.301199ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:30:25.990312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.805336ms","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-10T21:30:25.990338Z","caller":"traceutil/trace.go:171","msg":"trace[434718142] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:876; }","duration":"246.843867ms","start":"2026-02-10T21:30:25.743487Z","end":"2026-02-10T21:30:25.99033Z","steps":["trace[434718142] 'agreement among raft nodes before linearized reading' (duration: 246.771775ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:30:27.944704Z","caller":"traceutil/trace.go:171","msg":"trace[2007439387] linearizableReadLoop","detail":"{readStateIndex:917; appliedIndex:916; }","duration":"132.918597ms","start":"2026-02-10T21:30:27.811764Z","end":"2026-02-10T21:30:27.944682Z","steps":["trace[2007439387] 'read index received' (duration: 132.742893ms)","trace[2007439387] 'applied index is now lower than readState.Index' (duration: 174.744µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:30:27.944966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.179474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T21:30:27.945023Z","caller":"traceutil/trace.go:171","msg":"trace[1887147031] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:880; }","duration":"133.282367ms","start":"2026-02-10T21:30:27.811729Z","end":"2026-02-10T21:30:27.945012Z","steps":["trace[1887147031] 'agreement among raft nodes before linearized reading' (duration: 133.043041ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:30:27.945113Z","caller":"traceutil/trace.go:171","msg":"trace[926031132] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"218.819187ms","start":"2026-02-10T21:30:27.726258Z","end":"2026-02-10T21:30:27.945077Z","steps":["trace[926031132] 'process raft request' (duration: 218.306373ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:30:28.12655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.297528ms","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-10T21:30:28.126602Z","caller":"traceutil/trace.go:171","msg":"trace[1207245798] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:880; }","duration":"130.35632ms","start":"2026-02-10T21:30:27.996232Z","end":"2026-02-10T21:30:28.126588Z","steps":["trace[1207245798] 'range keys from in-memory index tree' (duration: 130.164054ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:30:28.126761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.326601ms","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-10T21:30:28.126779Z","caller":"traceutil/trace.go:171","msg":"trace[371614342] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:880; }","duration":"123.359572ms","start":"2026-02-10T21:30:28.003414Z","end":"2026-02-10T21:30:28.126773Z","steps":["trace[371614342] 'range keys from in-memory index tree' (duration: 123.27462ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:30:28.126887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.068365ms","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-10T21:30:28.126904Z","caller":"traceutil/trace.go:171","msg":"trace[1569097715] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:880; }","duration":"123.095325ms","start":"2026-02-10T21:30:28.003802Z","end":"2026-02-10T21:30:28.126898Z","steps":["trace[1569097715] 'range keys from in-memory index tree' (duration: 123.014193ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:30:34.102525Z","caller":"traceutil/trace.go:171","msg":"trace[137402803] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"131.581502ms","start":"2026-02-10T21:30:33.970923Z","end":"2026-02-10T21:30:34.102504Z","steps":["trace[137402803] 'process raft request' (duration: 68.068562ms)","trace[137402803] 'store kv pair into bolt db' {req_type:put; key:/registry/leases/kube-system/kube-controller-manager; req_size:488; } (duration: 63.386626ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:30:34.344568Z","caller":"traceutil/trace.go:171","msg":"trace[954296011] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"105.383281ms","start":"2026-02-10T21:30:34.239169Z","end":"2026-02-10T21:30:34.344552Z","steps":["trace[954296011] 'process raft request' (duration: 105.272418ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:30:34.344728Z","caller":"traceutil/trace.go:171","msg":"trace[102843225] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"105.496534ms","start":"2026-02-10T21:30:34.239225Z","end":"2026-02-10T21:30:34.344721Z","steps":["trace[102843225] 'process raft request' (duration: 105.300429ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:30:34.344832Z","caller":"traceutil/trace.go:171","msg":"trace[904590035] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"104.273991ms","start":"2026-02-10T21:30:34.240551Z","end":"2026-02-10T21:30:34.344825Z","steps":["trace[904590035] 'process raft request' (duration: 104.148058ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:30:44.613365Z","caller":"traceutil/trace.go:171","msg":"trace[1330031865] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"200.803454ms","start":"2026-02-10T21:30:44.412539Z","end":"2026-02-10T21:30:44.613343Z","steps":["trace[1330031865] 'process raft request' (duration: 200.675971ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:30:44.613887Z","caller":"traceutil/trace.go:171","msg":"trace[2091265145] linearizableReadLoop","detail":"{readStateIndex:1036; appliedIndex:1036; }","duration":"201.244447ms","start":"2026-02-10T21:30:44.41263Z","end":"2026-02-10T21:30:44.613875Z","steps":["trace[2091265145] 'read index received' (duration: 201.238526ms)","trace[2091265145] 'applied index is now lower than readState.Index' (duration: 3.001µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:30:44.614168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.518044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-02-10T21:30:44.614214Z","caller":"traceutil/trace.go:171","msg":"trace[842688275] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:995; }","duration":"201.588195ms","start":"2026-02-10T21:30:44.412614Z","end":"2026-02-10T21:30:44.614203Z","steps":["trace[842688275] 'agreement among raft nodes before linearized reading' (duration: 201.328288ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:30:44.674783Z","caller":"traceutil/trace.go:171","msg":"trace[892821198] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"190.492247ms","start":"2026-02-10T21:30:44.484266Z","end":"2026-02-10T21:30:44.674758Z","steps":["trace[892821198] 'process raft request' (duration: 190.432685ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:30:44.675367Z","caller":"traceutil/trace.go:171","msg":"trace[565640112] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"226.45738ms","start":"2026-02-10T21:30:44.448897Z","end":"2026-02-10T21:30:44.675355Z","steps":["trace[565640112] 'process raft request' (duration: 225.663198ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:30:45.302856Z","caller":"traceutil/trace.go:171","msg":"trace[1890286045] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"682.736684ms","start":"2026-02-10T21:30:44.620096Z","end":"2026-02-10T21:30:45.302833Z","steps":["trace[1890286045] 'process raft request' (duration: 587.003092ms)","trace[1890286045] 'compare' (duration: 95.594808ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:30:45.303172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:30:44.620079Z","time spent":"682.99984ms","remote":"127.0.0.1:37960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T21:30:45.356183Z","caller":"traceutil/trace.go:171","msg":"trace[875051691] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"675.119771ms","start":"2026-02-10T21:30:44.681048Z","end":"2026-02-10T21:30:45.356168Z","steps":["trace[875051691] 'process raft request' (duration: 674.751691ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:30:45.356347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:30:44.681031Z","time spent":"675.241014ms","remote":"127.0.0.1:37960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":495,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T21:30:45.35684Z","caller":"traceutil/trace.go:171","msg":"trace[764754845] linearizableReadLoop","detail":"{readStateIndex:1040; appliedIndex:1038; }","duration":"627.523388ms","start":"2026-02-10T21:30:44.728429Z","end":"2026-02-10T21:30:45.355953Z","steps":["trace[764754845] 'read index received' (duration: 478.750456ms)","trace[764754845] 'applied index is now lower than readState.Index' (duration: 148.771991ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:30:45.357439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.972796ms","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-10T21:30:45.357594Z","caller":"traceutil/trace.go:171","msg":"trace[1469714593] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:999; }","duration":"629.147751ms","start":"2026-02-10T21:30:44.728401Z","end":"2026-02-10T21:30:45.357549Z","steps":["trace[1469714593] 'agreement among raft nodes before linearized reading' (duration: 628.690359ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:30:45.357871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:30:44.728389Z","time spent":"629.365677ms","remote":"127.0.0.1:37960","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-10T21:30:45.358296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.143113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T21:30:45.358361Z","caller":"traceutil/trace.go:171","msg":"trace[1275998187] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:999; }","duration":"232.235515ms","start":"2026-02-10T21:30:45.126113Z","end":"2026-02-10T21:30:45.358348Z","steps":["trace[1275998187] 'agreement among raft nodes before linearized reading' (duration: 232.136883ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:30:46.241132Z","caller":"traceutil/trace.go:171","msg":"trace[1883130948] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"877.60963ms","start":"2026-02-10T21:30:45.363495Z","end":"2026-02-10T21:30:46.241105Z","steps":["trace[1883130948] 'process raft request' (duration: 856.385622ms)","trace[1883130948] 'compare' (duration: 20.326104ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:30:46.241741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:30:45.363481Z","time spent":"877.713723ms","remote":"127.0.0.1:37960","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-10T21:33:48.848091Z","caller":"traceutil/trace.go:171","msg":"trace[1936349991] transaction","detail":"{read_only:false; response_revision:1771; number_of_response:1; }","duration":"124.937276ms","start":"2026-02-10T21:33:48.723135Z","end":"2026-02-10T21:33:48.848073Z","steps":["trace[1936349991] 'process raft request' (duration: 124.817302ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:33:54.012188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.68473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-02-10T21:33:54.012255Z","caller":"traceutil/trace.go:171","msg":"trace[1507882377] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1798; }","duration":"121.781522ms","start":"2026-02-10T21:33:53.890458Z","end":"2026-02-10T21:33:54.012239Z","steps":["trace[1507882377] 'range keys from in-memory index tree' (duration: 121.536846ms)"],"step_count":1}