{"level":"warn","ts":"2026-02-02T18:10:14.826723Z","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-02T18:10:14.826854Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.225: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.225:2380","--initial-cluster=instance=https://199.204.45.225:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.225:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.225: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-02T18:10:14.826931Z","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-02T18:10:14.82694Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.225:2380"]} {"level":"info","ts":"2026-02-02T18:10:14.826957Z","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-02T18:10:14.82774Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.225:2379"]} {"level":"info","ts":"2026-02-02T18:10:14.827838Z","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.225:2380"],"listen-peer-urls":["https://199.204.45.225:2380"],"advertise-client-urls":["https://199.204.45.225:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.225:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.225: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-02T18:10:14.832601Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.128756ms"} {"level":"info","ts":"2026-02-02T18:10:14.846867Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e68635a2746608d1","cluster-id":"2a7f8712d7dbceef"} {"level":"info","ts":"2026-02-02T18:10:14.846926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 switched to configuration voters=()"} {"level":"info","ts":"2026-02-02T18:10:14.846943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 became follower at term 0"} {"level":"info","ts":"2026-02-02T18:10:14.846952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e68635a2746608d1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-02T18:10:14.84696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 became follower at term 1"} {"level":"info","ts":"2026-02-02T18:10:14.846988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 switched to configuration voters=(16611023247456471249)"} {"level":"warn","ts":"2026-02-02T18:10:14.856702Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-02T18:10:14.861308Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-02T18:10:14.867422Z","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-02T18:10:14.871002Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e68635a2746608d1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-02T18:10:14.876928Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e68635a2746608d1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-02T18:10:14.877314Z","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-02T18:10:14.877418Z","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-02T18:10:14.877451Z","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-02T18:10:14.878758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 switched to configuration voters=(16611023247456471249)"} {"level":"info","ts":"2026-02-02T18:10:14.884322Z","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-02T18:10:14.884968Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e68635a2746608d1","initial-advertise-peer-urls":["https://199.204.45.225:2380"],"listen-peer-urls":["https://199.204.45.225:2380"],"advertise-client-urls":["https://199.204.45.225:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.225:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-02T18:10:14.88531Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-02T18:10:14.885539Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2a7f8712d7dbceef","local-member-id":"e68635a2746608d1","added-peer-id":"e68635a2746608d1","added-peer-peer-urls":["https://199.204.45.225:2380"]} {"level":"info","ts":"2026-02-02T18:10:14.886128Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.225:2380"} {"level":"info","ts":"2026-02-02T18:10:14.886266Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.225:2380"} {"level":"info","ts":"2026-02-02T18:10:15.447784Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 is starting a new election at term 1"} {"level":"info","ts":"2026-02-02T18:10:15.447917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-02T18:10:15.447968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 received MsgPreVoteResp from e68635a2746608d1 at term 1"} {"level":"info","ts":"2026-02-02T18:10:15.448039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 became candidate at term 2"} {"level":"info","ts":"2026-02-02T18:10:15.448071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 received MsgVoteResp from e68635a2746608d1 at term 2"} {"level":"info","ts":"2026-02-02T18:10:15.448122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 became leader at term 2"} {"level":"info","ts":"2026-02-02T18:10:15.448155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e68635a2746608d1 elected leader e68635a2746608d1 at term 2"} {"level":"info","ts":"2026-02-02T18:10:15.449148Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e68635a2746608d1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.225:2379]}","request-path":"/0/members/e68635a2746608d1/attributes","cluster-id":"2a7f8712d7dbceef","publish-timeout":"7s"} {"level":"info","ts":"2026-02-02T18:10:15.449218Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-02T18:10:15.44929Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-02T18:10:15.456542Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.225:2379"} {"level":"info","ts":"2026-02-02T18:10:15.449345Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-02T18:10:15.458329Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2a7f8712d7dbceef","local-member-id":"e68635a2746608d1","cluster-version":"3.5"} {"level":"info","ts":"2026-02-02T18:10:15.45839Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-02T18:10:15.458714Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-02T18:10:15.461085Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-02T18:10:15.461257Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-02T18:10:15.462699Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-02T18:10:33.095503Z","caller":"traceutil/trace.go:171","msg":"trace[700531544] linearizableReadLoop","detail":"{readStateIndex:392; appliedIndex:391; }","duration":"147.947261ms","start":"2026-02-02T18:10:32.947532Z","end":"2026-02-02T18:10:33.095479Z","steps":["trace[700531544] 'read index received' (duration: 147.682725ms)","trace[700531544] 'applied index is now lower than readState.Index' (duration: 263.626µs)"],"step_count":2} {"level":"warn","ts":"2026-02-02T18:10:33.095745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.182897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4034"} {"level":"info","ts":"2026-02-02T18:10:33.095819Z","caller":"traceutil/trace.go:171","msg":"trace[381788800] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:381; }","duration":"148.29943ms","start":"2026-02-02T18:10:32.947504Z","end":"2026-02-02T18:10:33.095804Z","steps":["trace[381788800] 'agreement among raft nodes before linearized reading' (duration: 148.126246ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:10:33.096293Z","caller":"traceutil/trace.go:171","msg":"trace[927945554] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"452.09728ms","start":"2026-02-02T18:10:32.644183Z","end":"2026-02-02T18:10:33.09628Z","steps":["trace[927945554] 'process raft request' (duration: 451.128907ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:10:33.096973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:10:32.644165Z","time spent":"452.157121ms","remote":"127.0.0.1:52550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5255,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-02T18:10:33.54951Z","caller":"traceutil/trace.go:171","msg":"trace[1468774752] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"439.272113ms","start":"2026-02-02T18:10:33.110193Z","end":"2026-02-02T18:10:33.549465Z","steps":["trace[1468774752] 'process raft request' (duration: 439.071179ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:10:33.549698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:10:33.110179Z","time spent":"439.424238ms","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4158,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-02T18:10:33.555654Z","caller":"traceutil/trace.go:171","msg":"trace[1784031677] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"445.142664ms","start":"2026-02-02T18:10:33.110491Z","end":"2026-02-02T18:10:33.555633Z","steps":["trace[1784031677] 'process raft request' (duration: 444.819777ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:10:33.555774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:10:33.11046Z","time spent":"445.246607ms","remote":"127.0.0.1:52550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5083,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-02T18:10:35.937875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.723964ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-02T18:10:35.937994Z","caller":"traceutil/trace.go:171","msg":"trace[1784369694] linearizableReadLoop","detail":"{readStateIndex:431; appliedIndex:430; }","duration":"297.570721ms","start":"2026-02-02T18:10:35.640407Z","end":"2026-02-02T18:10:35.937978Z","steps":["trace[1784369694] 'read index received' (duration: 98.47298ms)","trace[1784369694] 'applied index is now lower than readState.Index' (duration: 199.096541ms)"],"step_count":2} {"level":"info","ts":"2026-02-02T18:10:35.938028Z","caller":"traceutil/trace.go:171","msg":"trace[198703820] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"331.077641ms","start":"2026-02-02T18:10:35.606929Z","end":"2026-02-02T18:10:35.938007Z","steps":["trace[198703820] 'process raft request' (duration: 131.962119ms)","trace[198703820] 'compare' (duration: 198.58368ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T18:10:35.938126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:10:35.606911Z","time spent":"331.160974ms","remote":"127.0.0.1:52600","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-02T18:10:35.938136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.725695ms","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-02T18:10:35.938185Z","caller":"traceutil/trace.go:171","msg":"trace[263817907] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:418; }","duration":"297.782847ms","start":"2026-02-02T18:10:35.640373Z","end":"2026-02-02T18:10:35.938156Z","steps":["trace[263817907] 'agreement among raft nodes before linearized reading' (duration: 297.704955ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:10:35.938302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.486072ms","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-02T18:10:35.938322Z","caller":"traceutil/trace.go:171","msg":"trace[1709556959] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:418; }","duration":"140.559885ms","start":"2026-02-02T18:10:35.797756Z","end":"2026-02-02T18:10:35.938316Z","steps":["trace[1709556959] 'agreement among raft nodes before linearized reading' (duration: 140.522324ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:10:47.15575Z","caller":"traceutil/trace.go:171","msg":"trace[1442992115] linearizableReadLoop","detail":"{readStateIndex:493; appliedIndex:492; }","duration":"267.72129ms","start":"2026-02-02T18:10:46.888008Z","end":"2026-02-02T18:10:47.155729Z","steps":["trace[1442992115] 'read index received' (duration: 267.545846ms)","trace[1442992115] 'applied index is now lower than readState.Index' (duration: 174.524µs)"],"step_count":2} {"level":"warn","ts":"2026-02-02T18:10:47.155858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.828872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-02T18:10:47.15589Z","caller":"traceutil/trace.go:171","msg":"trace[2124751268] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:478; }","duration":"267.900833ms","start":"2026-02-02T18:10:46.887977Z","end":"2026-02-02T18:10:47.155878Z","steps":["trace[2124751268] 'agreement among raft nodes before linearized reading' (duration: 267.836802ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:10:47.155984Z","caller":"traceutil/trace.go:171","msg":"trace[1899798290] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"401.864751ms","start":"2026-02-02T18:10:46.754094Z","end":"2026-02-02T18:10:47.155959Z","steps":["trace[1899798290] 'process raft request' (duration: 401.512464ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:10:47.156154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:10:46.754082Z","time spent":"401.980694ms","remote":"127.0.0.1:52540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4211,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-02T18:10:48.441287Z","caller":"traceutil/trace.go:171","msg":"trace[1341906452] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"441.125208ms","start":"2026-02-02T18:10:48.000146Z","end":"2026-02-02T18:10:48.441271Z","steps":["trace[1341906452] 'process raft request' (duration: 441.041936ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:10:48.441393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:10:48.000137Z","time spent":"441.196399ms","remote":"127.0.0.1:52600","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-02T18:10:48.442062Z","caller":"traceutil/trace.go:171","msg":"trace[213284869] linearizableReadLoop","detail":"{readStateIndex:495; appliedIndex:495; }","duration":"441.798324ms","start":"2026-02-02T18:10:48.000255Z","end":"2026-02-02T18:10:48.442053Z","steps":["trace[213284869] 'read index received' (duration: 441.795294ms)","trace[213284869] 'applied index is now lower than readState.Index' (duration: 2.53µs)"],"step_count":2} {"level":"warn","ts":"2026-02-02T18:10:48.442129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.868146ms","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-02T18:10:48.442153Z","caller":"traceutil/trace.go:171","msg":"trace[644563527] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:480; }","duration":"441.902596ms","start":"2026-02-02T18:10:48.000244Z","end":"2026-02-02T18:10:48.442147Z","steps":["trace[644563527] 'agreement among raft nodes before linearized reading' (duration: 441.852425ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:10:48.442175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:10:48.00024Z","time spent":"441.931077ms","remote":"127.0.0.1:52600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-02T18:10:48.517331Z","caller":"traceutil/trace.go:171","msg":"trace[1856502921] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"476.837531ms","start":"2026-02-02T18:10:48.040477Z","end":"2026-02-02T18:10:48.517314Z","steps":["trace[1856502921] 'process raft request' (duration: 476.750719ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:10:48.517449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:10:48.040461Z","time spent":"476.918423ms","remote":"127.0.0.1:52600","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-02T18:10:48.518394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.571543ms","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-02T18:10:48.518419Z","caller":"traceutil/trace.go:171","msg":"trace[1730659688] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:481; }","duration":"517.607204ms","start":"2026-02-02T18:10:48.000807Z","end":"2026-02-02T18:10:48.518414Z","steps":["trace[1730659688] 'agreement among raft nodes before linearized reading' (duration: 517.559542ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:10:48.518443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:10:48.000802Z","time spent":"517.636784ms","remote":"127.0.0.1:52600","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":"info","ts":"2026-02-02T18:10:48.644898Z","caller":"traceutil/trace.go:171","msg":"trace[1772379382] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"123.62661ms","start":"2026-02-02T18:10:48.521251Z","end":"2026-02-02T18:10:48.644878Z","steps":["trace[1772379382] 'process raft request' (duration: 123.585239ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:10:48.645219Z","caller":"traceutil/trace.go:171","msg":"trace[87918133] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"196.771305ms","start":"2026-02-02T18:10:48.448436Z","end":"2026-02-02T18:10:48.645207Z","steps":["trace[87918133] 'process raft request' (duration: 101.317548ms)","trace[87918133] 'compare' (duration: 94.908745ms)"],"step_count":2} {"level":"info","ts":"2026-02-02T18:10:49.803257Z","caller":"traceutil/trace.go:171","msg":"trace[947608448] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"127.205387ms","start":"2026-02-02T18:10:49.676031Z","end":"2026-02-02T18:10:49.803237Z","steps":["trace[947608448] 'process raft request' (duration: 127.124685ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:10:54.387839Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":635460681747841884,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-02T18:10:54.877975Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.059522337s","expected-duration":"1s"} {"level":"info","ts":"2026-02-02T18:10:54.878338Z","caller":"traceutil/trace.go:171","msg":"trace[1950901726] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"1.059953098s","start":"2026-02-02T18:10:53.818361Z","end":"2026-02-02T18:10:54.878314Z","steps":["trace[1950901726] 'process raft request' (duration: 1.059808194s)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:10:54.878536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:10:53.818346Z","time spent":"1.060116182s","remote":"127.0.0.1:52600","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-02T18:10:55.390642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.87028ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-02T18:10:55.390726Z","caller":"traceutil/trace.go:171","msg":"trace[1654869706] linearizableReadLoop","detail":"{readStateIndex:514; appliedIndex:513; }","duration":"1.503829643s","start":"2026-02-02T18:10:53.886884Z","end":"2026-02-02T18:10:55.390714Z","steps":["trace[1654869706] 'read index received' (duration: 991.556757ms)","trace[1654869706] 'applied index is now lower than readState.Index' (duration: 512.271876ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T18:10:55.390823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.503921705s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-02T18:10:55.390891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.026969ms","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-02T18:10:55.390897Z","caller":"traceutil/trace.go:171","msg":"trace[1628555403] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:497; }","duration":"1.504017737s","start":"2026-02-02T18:10:53.886863Z","end":"2026-02-02T18:10:55.39088Z","steps":["trace[1628555403] 'agreement among raft nodes before linearized reading' (duration: 1.503907554s)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:10:55.390947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:10:53.886854Z","time spent":"1.504083098s","remote":"127.0.0.1:52370","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-02T18:10:55.390981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.358991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8pmq7\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-02T18:10:55.390995Z","caller":"traceutil/trace.go:171","msg":"trace[1126242086] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8pmq7; range_end:; response_count:1; response_revision:497; }","duration":"792.395511ms","start":"2026-02-02T18:10:54.598595Z","end":"2026-02-02T18:10:55.390991Z","steps":["trace[1126242086] 'agreement among raft nodes before linearized reading' (duration: 792.370261ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:10:55.391013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:10:54.598585Z","time spent":"792.424933ms","remote":"127.0.0.1:52550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16679,"request content":"key:\"/registry/pods/kube-system/cilium-8pmq7\" "} {"level":"warn","ts":"2026-02-02T18:10:55.390859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.247344ms","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-02T18:10:55.391203Z","caller":"traceutil/trace.go:171","msg":"trace[473745739] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:497; }","duration":"884.609882ms","start":"2026-02-02T18:10:54.506581Z","end":"2026-02-02T18:10:55.391191Z","steps":["trace[473745739] 'agreement among raft nodes before linearized reading' (duration: 884.199602ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:10:55.391301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:10:54.506569Z","time spent":"884.721376ms","remote":"127.0.0.1:52600","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-02T18:10:55.390956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"723.551279ms","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-02T18:10:55.391406Z","caller":"traceutil/trace.go:171","msg":"trace[821729718] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:497; }","duration":"724.02618ms","start":"2026-02-02T18:10:54.667373Z","end":"2026-02-02T18:10:55.391399Z","steps":["trace[821729718] 'agreement among raft nodes before linearized reading' (duration: 723.552779ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:10:55.391443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:10:54.667363Z","time spent":"724.072951ms","remote":"127.0.0.1:52600","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":"info","ts":"2026-02-02T18:10:55.390908Z","caller":"traceutil/trace.go:171","msg":"trace[1175063044] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:497; }","duration":"721.051389ms","start":"2026-02-02T18:10:54.66985Z","end":"2026-02-02T18:10:55.390902Z","steps":["trace[1175063044] 'agreement among raft nodes before linearized reading' (duration: 721.025879ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:10:55.391536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:10:54.669844Z","time spent":"721.686855ms","remote":"127.0.0.1:52600","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-02T18:10:57.121412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.630046ms","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-02T18:10:57.121498Z","caller":"traceutil/trace.go:171","msg":"trace[1211094401] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:509; }","duration":"238.756059ms","start":"2026-02-02T18:10:56.882722Z","end":"2026-02-02T18:10:57.121478Z","steps":["trace[1211094401] 'range keys from in-memory index tree' (duration: 238.547844ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:10:57.121926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.904073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-02T18:10:57.12197Z","caller":"traceutil/trace.go:171","msg":"trace[338140263] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:509; }","duration":"233.980345ms","start":"2026-02-02T18:10:56.887979Z","end":"2026-02-02T18:10:57.121959Z","steps":["trace[338140263] 'range keys from in-memory index tree' (duration: 233.849451ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:10:59.929012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.972203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-02-02T18:10:59.929105Z","caller":"traceutil/trace.go:171","msg":"trace[961991282] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:570; }","duration":"130.119216ms","start":"2026-02-02T18:10:59.798964Z","end":"2026-02-02T18:10:59.929084Z","steps":["trace[961991282] 'range keys from in-memory index tree' (duration: 129.88513ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:11:15.624206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.901936ms","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-02T18:11:15.624287Z","caller":"traceutil/trace.go:171","msg":"trace[331975373] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:689; }","duration":"121.001217ms","start":"2026-02-02T18:11:15.503272Z","end":"2026-02-02T18:11:15.624273Z","steps":["trace[331975373] 'range keys from in-memory index tree' (duration: 120.776392ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:11:15.62448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.803318ms","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-02T18:11:15.624509Z","caller":"traceutil/trace.go:171","msg":"trace[1611260837] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:689; }","duration":"147.826288ms","start":"2026-02-02T18:11:15.47667Z","end":"2026-02-02T18:11:15.624496Z","steps":["trace[1611260837] 'range keys from in-memory index tree' (duration: 147.646944ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:11:15.624543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.153656ms","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-02T18:11:15.624589Z","caller":"traceutil/trace.go:171","msg":"trace[1114630453] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:689; }","duration":"143.235268ms","start":"2026-02-02T18:11:15.481344Z","end":"2026-02-02T18:11:15.624579Z","steps":["trace[1114630453] 'range keys from in-memory index tree' (duration: 142.983183ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:11:15.905794Z","caller":"traceutil/trace.go:171","msg":"trace[118382579] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"277.76076ms","start":"2026-02-02T18:11:15.628007Z","end":"2026-02-02T18:11:15.905767Z","steps":["trace[118382579] 'process raft request' (duration: 216.675272ms)","trace[118382579] 'compare' (duration: 60.75351ms)"],"step_count":2} {"level":"info","ts":"2026-02-02T18:11:15.906065Z","caller":"traceutil/trace.go:171","msg":"trace[2102684607] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"274.901671ms","start":"2026-02-02T18:11:15.631154Z","end":"2026-02-02T18:11:15.906056Z","steps":["trace[2102684607] 'process raft request' (duration: 274.568733ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:11:15.906148Z","caller":"traceutil/trace.go:171","msg":"trace[24824159] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"276.386166ms","start":"2026-02-02T18:11:15.629754Z","end":"2026-02-02T18:11:15.90614Z","steps":["trace[24824159] 'process raft request' (duration: 275.874664ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:11:27.722769Z","caller":"traceutil/trace.go:171","msg":"trace[888345837] linearizableReadLoop","detail":"{readStateIndex:753; appliedIndex:752; }","duration":"338.766197ms","start":"2026-02-02T18:11:27.383986Z","end":"2026-02-02T18:11:27.722753Z","steps":["trace[888345837] 'read index received' (duration: 338.739837ms)","trace[888345837] 'applied index is now lower than readState.Index' (duration: 25.67µs)"],"step_count":2} {"level":"warn","ts":"2026-02-02T18:11:27.722875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.86986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-02T18:11:27.722892Z","caller":"traceutil/trace.go:171","msg":"trace[1536511746] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:728; }","duration":"338.932152ms","start":"2026-02-02T18:11:27.383955Z","end":"2026-02-02T18:11:27.722887Z","steps":["trace[1536511746] 'agreement among raft nodes before linearized reading' (duration: 338.86343ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:11:27.722912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:11:27.383941Z","time spent":"338.965972ms","remote":"127.0.0.1:52364","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-02T18:11:27.723062Z","caller":"traceutil/trace.go:171","msg":"trace[932935990] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"378.994678ms","start":"2026-02-02T18:11:27.344061Z","end":"2026-02-02T18:11:27.723056Z","steps":["trace[932935990] 'process raft request' (duration: 378.578328ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:11:27.723138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:11:27.344053Z","time spent":"379.022428ms","remote":"127.0.0.1:52600","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-02T18:11:29.641947Z","caller":"traceutil/trace.go:171","msg":"trace[890634945] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"214.600177ms","start":"2026-02-02T18:11:29.427325Z","end":"2026-02-02T18:11:29.641925Z","steps":["trace[890634945] 'process raft request' (duration: 214.482744ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:11:30.285437Z","caller":"traceutil/trace.go:171","msg":"trace[998966558] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"256.574678ms","start":"2026-02-02T18:11:30.028846Z","end":"2026-02-02T18:11:30.285421Z","steps":["trace[998966558] 'process raft request' (duration: 256.479906ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:11:30.317112Z","caller":"traceutil/trace.go:171","msg":"trace[2126294379] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"286.788337ms","start":"2026-02-02T18:11:30.030305Z","end":"2026-02-02T18:11:30.317093Z","steps":["trace[2126294379] 'process raft request' (duration: 286.684535ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:11:42.78488Z","caller":"traceutil/trace.go:171","msg":"trace[1590798077] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"168.338194ms","start":"2026-02-02T18:11:42.616503Z","end":"2026-02-02T18:11:42.784841Z","steps":["trace[1590798077] 'process raft request' (duration: 168.204411ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:11:43.924458Z","caller":"traceutil/trace.go:171","msg":"trace[362838193] linearizableReadLoop","detail":"{readStateIndex:802; appliedIndex:801; }","duration":"116.213722ms","start":"2026-02-02T18:11:43.808227Z","end":"2026-02-02T18:11:43.924441Z","steps":["trace[362838193] 'read index received' (duration: 116.055078ms)","trace[362838193] 'applied index is now lower than readState.Index' (duration: 157.894µs)"],"step_count":2} {"level":"info","ts":"2026-02-02T18:11:43.924706Z","caller":"traceutil/trace.go:171","msg":"trace[1241058581] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"127.424538ms","start":"2026-02-02T18:11:43.797256Z","end":"2026-02-02T18:11:43.92468Z","steps":["trace[1241058581] 'process raft request' (duration: 127.07034ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:11:43.924893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.648232ms","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-02T18:11:43.925505Z","caller":"traceutil/trace.go:171","msg":"trace[1204969754] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:774; }","duration":"117.275576ms","start":"2026-02-02T18:11:43.808213Z","end":"2026-02-02T18:11:43.925489Z","steps":["trace[1204969754] 'agreement among raft nodes before linearized reading' (duration: 116.56293ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:11:44.395048Z","caller":"traceutil/trace.go:171","msg":"trace[2112988288] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"464.790512ms","start":"2026-02-02T18:11:43.930231Z","end":"2026-02-02T18:11:44.395022Z","steps":["trace[2112988288] 'process raft request' (duration: 370.884493ms)","trace[2112988288] 'compare' (duration: 93.620632ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T18:11:44.395205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:11:43.930218Z","time spent":"464.912546ms","remote":"127.0.0.1:52600","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-02T18:11:44.854045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.055925ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-02T18:11:44.854157Z","caller":"traceutil/trace.go:171","msg":"trace[1359439378] linearizableReadLoop","detail":"{readStateIndex:804; appliedIndex:802; }","duration":"786.8172ms","start":"2026-02-02T18:11:44.06732Z","end":"2026-02-02T18:11:44.854138Z","steps":["trace[1359439378] 'read index received' (duration: 233.885246ms)","trace[1359439378] 'applied index is now lower than readState.Index' (duration: 552.930184ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T18:11:44.854492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"787.160418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-02T18:11:44.854563Z","caller":"traceutil/trace.go:171","msg":"trace[942379812] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:775; }","duration":"787.26974ms","start":"2026-02-02T18:11:44.067272Z","end":"2026-02-02T18:11:44.854542Z","steps":["trace[942379812] 'agreement among raft nodes before linearized reading' (duration: 787.083786ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:11:44.8546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.655837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-02-02T18:11:44.85463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:11:44.067254Z","time spent":"787.362272ms","remote":"127.0.0.1:52600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-02T18:11:44.85464Z","caller":"traceutil/trace.go:171","msg":"trace[527807311] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:775; }","duration":"521.75846ms","start":"2026-02-02T18:11:44.33287Z","end":"2026-02-02T18:11:44.854628Z","steps":["trace[527807311] 'agreement among raft nodes before linearized reading' (duration: 521.554525ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:11:44.854719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:11:44.332853Z","time spent":"521.856872ms","remote":"127.0.0.1:52600","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-02T18:11:44.85485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.285365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-02-02T18:11:44.856335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.683741ms","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-02T18:11:44.856377Z","caller":"traceutil/trace.go:171","msg":"trace[1941128112] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:775; }","duration":"485.768573ms","start":"2026-02-02T18:11:44.370596Z","end":"2026-02-02T18:11:44.856364Z","steps":["trace[1941128112] 'agreement among raft nodes before linearized reading' (duration: 485.65363ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:11:44.856413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:11:44.370573Z","time spent":"485.833165ms","remote":"127.0.0.1:52600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-02T18:11:44.854876Z","caller":"traceutil/trace.go:171","msg":"trace[536297979] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:775; }","duration":"468.335675ms","start":"2026-02-02T18:11:44.386532Z","end":"2026-02-02T18:11:44.854867Z","steps":["trace[536297979] 'agreement among raft nodes before linearized reading' (duration: 468.293084ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:11:44.858399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:11:44.38652Z","time spent":"471.819529ms","remote":"127.0.0.1:52540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"info","ts":"2026-02-02T18:11:44.971835Z","caller":"traceutil/trace.go:171","msg":"trace[555151661] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"110.462035ms","start":"2026-02-02T18:11:44.861351Z","end":"2026-02-02T18:11:44.971813Z","steps":["trace[555151661] 'process raft request' (duration: 110.330242ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:11:44.988928Z","caller":"traceutil/trace.go:171","msg":"trace[1375683838] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"127.1162ms","start":"2026-02-02T18:11:44.861794Z","end":"2026-02-02T18:11:44.98891Z","steps":["trace[1375683838] 'process raft request' (duration: 126.684401ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:11:44.98969Z","caller":"traceutil/trace.go:171","msg":"trace[1658956176] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"126.100607ms","start":"2026-02-02T18:11:44.86358Z","end":"2026-02-02T18:11:44.98968Z","steps":["trace[1658956176] 'process raft request' (duration: 124.987941ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:11:56.191192Z","caller":"traceutil/trace.go:171","msg":"trace[969939696] linearizableReadLoop","detail":"{readStateIndex:891; appliedIndex:890; }","duration":"136.111875ms","start":"2026-02-02T18:11:56.055063Z","end":"2026-02-02T18:11:56.191175Z","steps":["trace[969939696] 'read index received' (duration: 135.964201ms)","trace[969939696] 'applied index is now lower than readState.Index' (duration: 145.084µs)"],"step_count":2} {"level":"info","ts":"2026-02-02T18:11:56.19141Z","caller":"traceutil/trace.go:171","msg":"trace[270420261] transaction","detail":"{read_only:false; response_revision:858; number_of_response:1; }","duration":"172.135515ms","start":"2026-02-02T18:11:56.019265Z","end":"2026-02-02T18:11:56.191401Z","steps":["trace[270420261] 'process raft request' (duration: 171.808497ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:11:56.191676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.574966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-02T18:11:56.191705Z","caller":"traceutil/trace.go:171","msg":"trace[2036592368] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:858; }","duration":"136.657718ms","start":"2026-02-02T18:11:56.055037Z","end":"2026-02-02T18:11:56.191695Z","steps":["trace[2036592368] 'agreement among raft nodes before linearized reading' (duration: 136.580246ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:11:57.438312Z","caller":"traceutil/trace.go:171","msg":"trace[1814926908] linearizableReadLoop","detail":"{readStateIndex:893; appliedIndex:892; }","duration":"402.831096ms","start":"2026-02-02T18:11:57.035464Z","end":"2026-02-02T18:11:57.438296Z","steps":["trace[1814926908] 'read index received' (duration: 402.707063ms)","trace[1814926908] 'applied index is now lower than readState.Index' (duration: 123.303µs)"],"step_count":2} {"level":"info","ts":"2026-02-02T18:11:57.4384Z","caller":"traceutil/trace.go:171","msg":"trace[1528389595] transaction","detail":"{read_only:false; response_revision:860; number_of_response:1; }","duration":"413.208492ms","start":"2026-02-02T18:11:57.025186Z","end":"2026-02-02T18:11:57.438395Z","steps":["trace[1528389595] 'process raft request' (duration: 413.007458ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:11:57.438497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:11:57.025178Z","time spent":"413.236732ms","remote":"127.0.0.1:52600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-02T18:11:57.438633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.81448ms","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-02T18:11:57.438698Z","caller":"traceutil/trace.go:171","msg":"trace[2015642554] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:860; }","duration":"401.895692ms","start":"2026-02-02T18:11:57.03679Z","end":"2026-02-02T18:11:57.438686Z","steps":["trace[2015642554] 'agreement among raft nodes before linearized reading' (duration: 401.754619ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:11:57.438722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:11:57.036786Z","time spent":"401.931193ms","remote":"127.0.0.1:52600","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-02T18:11:57.438766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.300006ms","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-02T18:11:57.438786Z","caller":"traceutil/trace.go:171","msg":"trace[1947300793] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:860; }","duration":"403.320136ms","start":"2026-02-02T18:11:57.035461Z","end":"2026-02-02T18:11:57.438781Z","steps":["trace[1947300793] 'agreement among raft nodes before linearized reading' (duration: 403.251345ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:11:57.438801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:11:57.035437Z","time spent":"403.361598ms","remote":"127.0.0.1:52600","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-02T18:11:57.438828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.589075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-02T18:11:57.438851Z","caller":"traceutil/trace.go:171","msg":"trace[728731450] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:860; }","duration":"102.638927ms","start":"2026-02-02T18:11:57.336208Z","end":"2026-02-02T18:11:57.438847Z","steps":["trace[728731450] 'agreement among raft nodes before linearized reading' (duration: 102.602906ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:11:57.969592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.978643ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-02T18:11:57.969755Z","caller":"traceutil/trace.go:171","msg":"trace[1975181022] linearizableReadLoop","detail":"{readStateIndex:895; appliedIndex:893; }","duration":"243.459265ms","start":"2026-02-02T18:11:57.726282Z","end":"2026-02-02T18:11:57.969742Z","steps":["trace[1975181022] 'read index received' (duration: 242.724937ms)","trace[1975181022] 'applied index is now lower than readState.Index' (duration: 733.748µs)"],"step_count":2} {"level":"info","ts":"2026-02-02T18:11:57.969916Z","caller":"traceutil/trace.go:171","msg":"trace[1616660919] transaction","detail":"{read_only:false; response_revision:861; number_of_response:1; }","duration":"523.014571ms","start":"2026-02-02T18:11:57.446894Z","end":"2026-02-02T18:11:57.969908Z","steps":["trace[1616660919] 'process raft request' (duration: 105.66366ms)","trace[1616660919] 'compare' (duration: 416.810058ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T18:11:57.969963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:11:57.446881Z","time spent":"523.058833ms","remote":"127.0.0.1:52600","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-02T18:11:57.970072Z","caller":"traceutil/trace.go:171","msg":"trace[796416825] transaction","detail":"{read_only:false; response_revision:862; number_of_response:1; }","duration":"523.061513ms","start":"2026-02-02T18:11:57.447003Z","end":"2026-02-02T18:11:57.970064Z","steps":["trace[796416825] 'process raft request' (duration: 522.659083ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:11:57.970105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:11:57.446998Z","time spent":"523.088623ms","remote":"127.0.0.1:52600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-02T18:11:57.970184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.901196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-02T18:11:57.970201Z","caller":"traceutil/trace.go:171","msg":"trace[1673018644] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:862; }","duration":"243.938257ms","start":"2026-02-02T18:11:57.726257Z","end":"2026-02-02T18:11:57.970195Z","steps":["trace[1673018644] 'agreement among raft nodes before linearized reading' (duration: 243.910636ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:11:58.336363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.207528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-02T18:11:58.336434Z","caller":"traceutil/trace.go:171","msg":"trace[260170287] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:862; }","duration":"141.329761ms","start":"2026-02-02T18:11:58.195087Z","end":"2026-02-02T18:11:58.336417Z","steps":["trace[260170287] 'range keys from in-memory index tree' (duration: 141.029393ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:11:58.517065Z","caller":"traceutil/trace.go:171","msg":"trace[1229558459] transaction","detail":"{read_only:false; response_revision:863; number_of_response:1; }","duration":"177.037221ms","start":"2026-02-02T18:11:58.340011Z","end":"2026-02-02T18:11:58.517048Z","steps":["trace[1229558459] 'process raft request' (duration: 176.939949ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:11:59.561001Z","caller":"traceutil/trace.go:171","msg":"trace[1825160751] transaction","detail":"{read_only:false; response_revision:866; number_of_response:1; }","duration":"117.343758ms","start":"2026-02-02T18:11:59.443641Z","end":"2026-02-02T18:11:59.560985Z","steps":["trace[1825160751] 'process raft request' (duration: 117.03713ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:12:04.044127Z","caller":"traceutil/trace.go:171","msg":"trace[328292479] linearizableReadLoop","detail":"{readStateIndex:911; appliedIndex:910; }","duration":"472.716672ms","start":"2026-02-02T18:12:03.571397Z","end":"2026-02-02T18:12:04.044114Z","steps":["trace[328292479] 'read index received' (duration: 472.593669ms)","trace[328292479] 'applied index is now lower than readState.Index' (duration: 122.623µs)"],"step_count":2} {"level":"info","ts":"2026-02-02T18:12:04.044284Z","caller":"traceutil/trace.go:171","msg":"trace[1690386550] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"820.592436ms","start":"2026-02-02T18:12:03.223685Z","end":"2026-02-02T18:12:04.044278Z","steps":["trace[1690386550] 'process raft request' (duration: 820.34659ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:12:04.044356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:12:03.223672Z","time spent":"820.626747ms","remote":"127.0.0.1:52600","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-02T18:12:04.044492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.094351ms","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-02T18:12:04.044507Z","caller":"traceutil/trace.go:171","msg":"trace[574767845] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:877; }","duration":"473.131501ms","start":"2026-02-02T18:12:03.571371Z","end":"2026-02-02T18:12:04.044503Z","steps":["trace[574767845] 'agreement among raft nodes before linearized reading' (duration: 473.07043ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:12:04.044519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:12:03.571359Z","time spent":"473.157282ms","remote":"127.0.0.1:52600","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-02T18:12:04.309733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.707933ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-02T18:12:04.31016Z","caller":"traceutil/trace.go:171","msg":"trace[1785353284] linearizableReadLoop","detail":"{readStateIndex:912; appliedIndex:911; }","duration":"265.979082ms","start":"2026-02-02T18:12:04.044166Z","end":"2026-02-02T18:12:04.310145Z","steps":["trace[1785353284] 'read index received' (duration: 28.853508ms)","trace[1785353284] 'applied index is now lower than readState.Index' (duration: 237.123464ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T18:12:04.310213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.636932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-02T18:12:04.31023Z","caller":"traceutil/trace.go:171","msg":"trace[1376405652] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:877; }","duration":"423.684683ms","start":"2026-02-02T18:12:03.886539Z","end":"2026-02-02T18:12:04.310224Z","steps":["trace[1376405652] 'agreement among raft nodes before linearized reading' (duration: 423.643642ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:12:04.310251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:12:03.886528Z","time spent":"423.718893ms","remote":"127.0.0.1:52364","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-02T18:12:04.310394Z","caller":"traceutil/trace.go:171","msg":"trace[1824381843] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"263.282858ms","start":"2026-02-02T18:12:04.047105Z","end":"2026-02-02T18:12:04.310387Z","steps":["trace[1824381843] 'process raft request' (duration: 262.708414ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:12:04.310542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.819062ms","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-02T18:12:04.31056Z","caller":"traceutil/trace.go:171","msg":"trace[767347651] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:878; }","duration":"287.851384ms","start":"2026-02-02T18:12:04.022703Z","end":"2026-02-02T18:12:04.310555Z","steps":["trace[767347651] 'agreement among raft nodes before linearized reading' (duration: 287.769642ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:12:04.310659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.230459ms","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-02T18:12:04.310709Z","caller":"traceutil/trace.go:171","msg":"trace[1368325702] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:878; }","duration":"300.31188ms","start":"2026-02-02T18:12:04.010392Z","end":"2026-02-02T18:12:04.310703Z","steps":["trace[1368325702] 'agreement among raft nodes before linearized reading' (duration: 300.232668ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:12:04.310727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:12:04.01038Z","time spent":"300.342152ms","remote":"127.0.0.1:52600","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-02T18:12:04.310818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.547073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-02T18:12:04.310835Z","caller":"traceutil/trace.go:171","msg":"trace[799004502] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:878; }","duration":"385.598884ms","start":"2026-02-02T18:12:03.925231Z","end":"2026-02-02T18:12:04.310829Z","steps":["trace[799004502] 'agreement among raft nodes before linearized reading' (duration: 385.566433ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:12:04.310853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:12:03.925215Z","time spent":"385.633486ms","remote":"127.0.0.1:52660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":14,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"info","ts":"2026-02-02T18:12:10.478262Z","caller":"traceutil/trace.go:171","msg":"trace[662329328] linearizableReadLoop","detail":"{readStateIndex:931; appliedIndex:930; }","duration":"136.363602ms","start":"2026-02-02T18:12:10.341868Z","end":"2026-02-02T18:12:10.478232Z","steps":["trace[662329328] 'read index received' (duration: 4.776705ms)","trace[662329328] 'applied index is now lower than readState.Index' (duration: 131.586427ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T18:12:10.478412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.513256ms","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-02T18:12:10.478431Z","caller":"traceutil/trace.go:171","msg":"trace[1337075539] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:895; }","duration":"136.566877ms","start":"2026-02-02T18:12:10.341857Z","end":"2026-02-02T18:12:10.478424Z","steps":["trace[1337075539] 'agreement among raft nodes before linearized reading' (duration: 136.452934ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:12:10.478415Z","caller":"traceutil/trace.go:171","msg":"trace[91068056] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"137.086958ms","start":"2026-02-02T18:12:10.341309Z","end":"2026-02-02T18:12:10.478396Z","steps":["trace[91068056] 'process raft request' (duration: 134.322042ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:12:12.673806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.378829ms","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-02T18:12:12.673854Z","caller":"traceutil/trace.go:171","msg":"trace[1614009275] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:900; }","duration":"112.45718ms","start":"2026-02-02T18:12:12.561386Z","end":"2026-02-02T18:12:12.673843Z","steps":["trace[1614009275] 'range keys from in-memory index tree' (duration: 112.274277ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:12:12.673923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.344122ms","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-02T18:12:12.673979Z","caller":"traceutil/trace.go:171","msg":"trace[1602261305] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:900; }","duration":"191.424804ms","start":"2026-02-02T18:12:12.482537Z","end":"2026-02-02T18:12:12.673962Z","steps":["trace[1602261305] 'range keys from in-memory index tree' (duration: 191.222489ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:12:12.673988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.065365ms","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-02T18:12:12.674003Z","caller":"traceutil/trace.go:171","msg":"trace[1305591025] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:900; }","duration":"105.090555ms","start":"2026-02-02T18:12:12.568908Z","end":"2026-02-02T18:12:12.673998Z","steps":["trace[1305591025] 'range keys from in-memory index tree' (duration: 105.008513ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:12:12.674085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.238586ms","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-02T18:12:12.674105Z","caller":"traceutil/trace.go:171","msg":"trace[46476565] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:900; }","duration":"190.281608ms","start":"2026-02-02T18:12:12.483818Z","end":"2026-02-02T18:12:12.674099Z","steps":["trace[46476565] 'range keys from in-memory index tree' (duration: 190.157415ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:12:12.813281Z","caller":"traceutil/trace.go:171","msg":"trace[2120016171] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"135.46988ms","start":"2026-02-02T18:12:12.677789Z","end":"2026-02-02T18:12:12.813259Z","steps":["trace[2120016171] 'process raft request' (duration: 135.333457ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:12:12.820875Z","caller":"traceutil/trace.go:171","msg":"trace[1250982805] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"141.375141ms","start":"2026-02-02T18:12:12.679489Z","end":"2026-02-02T18:12:12.820864Z","steps":["trace[1250982805] 'process raft request' (duration: 141.357391ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:12:12.820961Z","caller":"traceutil/trace.go:171","msg":"trace[1711325204] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"142.913617ms","start":"2026-02-02T18:12:12.678028Z","end":"2026-02-02T18:12:12.820942Z","steps":["trace[1711325204] 'process raft request' (duration: 142.712112ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:12:12.821012Z","caller":"traceutil/trace.go:171","msg":"trace[1978472582] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"142.878287ms","start":"2026-02-02T18:12:12.678127Z","end":"2026-02-02T18:12:12.821005Z","steps":["trace[1978472582] 'process raft request' (duration: 142.689942ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:12:14.059361Z","caller":"traceutil/trace.go:171","msg":"trace[1261759380] linearizableReadLoop","detail":"{readStateIndex:941; appliedIndex:940; }","duration":"149.497434ms","start":"2026-02-02T18:12:13.909847Z","end":"2026-02-02T18:12:14.059345Z","steps":["trace[1261759380] 'read index received' (duration: 103.807165ms)","trace[1261759380] 'applied index is now lower than readState.Index' (duration: 45.689389ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T18:12:14.059454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.583196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-02T18:12:14.059489Z","caller":"traceutil/trace.go:171","msg":"trace[650327973] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:904; }","duration":"149.651757ms","start":"2026-02-02T18:12:13.909818Z","end":"2026-02-02T18:12:14.05947Z","steps":["trace[650327973] 'agreement among raft nodes before linearized reading' (duration: 149.589255ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:12:29.27584Z","caller":"traceutil/trace.go:171","msg":"trace[120723438] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"357.162366ms","start":"2026-02-02T18:12:28.918616Z","end":"2026-02-02T18:12:29.275779Z","steps":["trace[120723438] 'process raft request' (duration: 293.812967ms)","trace[120723438] 'compare' (duration: 62.499168ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T18:12:29.276015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:12:28.918591Z","time spent":"357.333831ms","remote":"127.0.0.1:52392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-02T18:12:29.748646Z","caller":"traceutil/trace.go:171","msg":"trace[958960049] linearizableReadLoop","detail":"{readStateIndex:1052; appliedIndex:1048; }","duration":"470.36723ms","start":"2026-02-02T18:12:29.278261Z","end":"2026-02-02T18:12:29.748628Z","steps":["trace[958960049] 'read index received' (duration: 387.714794ms)","trace[958960049] 'applied index is now lower than readState.Index' (duration: 82.651776ms)"],"step_count":2} {"level":"info","ts":"2026-02-02T18:12:29.748871Z","caller":"traceutil/trace.go:171","msg":"trace[1977818610] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"829.479534ms","start":"2026-02-02T18:12:28.919378Z","end":"2026-02-02T18:12:29.748857Z","steps":["trace[1977818610] 'process raft request' (duration: 746.664514ms)","trace[1977818610] 'compare' (duration: 82.374839ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T18:12:29.748955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:12:28.919361Z","time spent":"829.538066ms","remote":"127.0.0.1:52600","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-02T18:12:29.749098Z","caller":"traceutil/trace.go:171","msg":"trace[281551709] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"827.901876ms","start":"2026-02-02T18:12:28.921188Z","end":"2026-02-02T18:12:29.74909Z","steps":["trace[281551709] 'process raft request' (duration: 827.359363ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:12:29.749147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:12:28.921182Z","time spent":"827.942187ms","remote":"127.0.0.1:52600","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-02T18:12:29.74925Z","caller":"traceutil/trace.go:171","msg":"trace[173363336] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"734.874138ms","start":"2026-02-02T18:12:29.014367Z","end":"2026-02-02T18:12:29.749241Z","steps":["trace[173363336] 'process raft request' (duration: 734.211742ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:12:29.749294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:12:29.01435Z","time spent":"734.92386ms","remote":"127.0.0.1:52600","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-02T18:12:29.749389Z","caller":"traceutil/trace.go:171","msg":"trace[1103529589] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"734.207573ms","start":"2026-02-02T18:12:29.015174Z","end":"2026-02-02T18:12:29.749382Z","steps":["trace[1103529589] 'process raft request' (duration: 733.424884ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:12:29.749433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:12:29.015168Z","time spent":"734.244794ms","remote":"127.0.0.1:52600","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-02T18:12:29.749545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.289603ms","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-02T18:12:29.749577Z","caller":"traceutil/trace.go:171","msg":"trace[73506625] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1012; }","duration":"471.350304ms","start":"2026-02-02T18:12:29.278219Z","end":"2026-02-02T18:12:29.749569Z","steps":["trace[73506625] 'agreement among raft nodes before linearized reading' (duration: 471.295673ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:12:29.749599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:12:29.278177Z","time spent":"471.416426ms","remote":"127.0.0.1:52538","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":"warn","ts":"2026-02-02T18:12:29.749762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.134928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-02-02T18:12:29.749805Z","caller":"traceutil/trace.go:171","msg":"trace[1315325071] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1012; }","duration":"247.20902ms","start":"2026-02-02T18:12:29.502587Z","end":"2026-02-02T18:12:29.749796Z","steps":["trace[1315325071] 'agreement among raft nodes before linearized reading' (duration: 247.112458ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:12:29.750074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.804687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:536"} {"level":"info","ts":"2026-02-02T18:12:29.750103Z","caller":"traceutil/trace.go:171","msg":"trace[167449547] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1012; }","duration":"115.834247ms","start":"2026-02-02T18:12:29.634262Z","end":"2026-02-02T18:12:29.750096Z","steps":["trace[167449547] 'agreement among raft nodes before linearized reading' (duration: 115.765256ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:12:29.750227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.643891ms","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-02T18:12:29.750253Z","caller":"traceutil/trace.go:171","msg":"trace[1712136102] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1012; }","duration":"117.694372ms","start":"2026-02-02T18:12:29.632552Z","end":"2026-02-02T18:12:29.750247Z","steps":["trace[1712136102] 'agreement among raft nodes before linearized reading' (duration: 117.633071ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:12:29.750356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.460473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-02T18:12:29.750384Z","caller":"traceutil/trace.go:171","msg":"trace[778010890] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1012; }","duration":"128.508183ms","start":"2026-02-02T18:12:29.621868Z","end":"2026-02-02T18:12:29.750376Z","steps":["trace[778010890] 'agreement among raft nodes before linearized reading' (duration: 128.465482ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:12:30.492016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.497755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-02T18:12:30.492437Z","caller":"traceutil/trace.go:171","msg":"trace[1783934864] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1015; }","duration":"600.946835ms","start":"2026-02-02T18:12:29.891461Z","end":"2026-02-02T18:12:30.492408Z","steps":["trace[1783934864] 'range keys from in-memory index tree' (duration: 600.396282ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:12:30.492618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T18:12:29.891428Z","time spent":"601.13358ms","remote":"127.0.0.1:52364","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-02T18:15:04.779505Z","caller":"traceutil/trace.go:171","msg":"trace[1075748604] transaction","detail":"{read_only:false; response_revision:1645; number_of_response:1; }","duration":"151.136539ms","start":"2026-02-02T18:15:04.628327Z","end":"2026-02-02T18:15:04.779463Z","steps":["trace[1075748604] 'process raft request' (duration: 151.049947ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T18:15:04.783871Z","caller":"traceutil/trace.go:171","msg":"trace[1466753064] transaction","detail":"{read_only:false; response_revision:1644; number_of_response:1; }","duration":"155.591427ms","start":"2026-02-02T18:15:04.62826Z","end":"2026-02-02T18:15:04.783851Z","steps":["trace[1466753064] 'process raft request' (duration: 110.491527ms)","trace[1466753064] 'compare' (duration: 40.492849ms)"],"step_count":2} {"level":"info","ts":"2026-02-02T18:15:04.779772Z","caller":"traceutil/trace.go:171","msg":"trace[1554830997] transaction","detail":"{read_only:false; response_revision:1646; number_of_response:1; }","duration":"131.182221ms","start":"2026-02-02T18:15:04.648553Z","end":"2026-02-02T18:15:04.779735Z","steps":["trace[1554830997] 'process raft request' (duration: 130.868573ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:15:36.931953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.146334ms","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-02T18:15:36.932004Z","caller":"traceutil/trace.go:171","msg":"trace[1451752433] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1804; }","duration":"210.227235ms","start":"2026-02-02T18:15:36.721765Z","end":"2026-02-02T18:15:36.931993Z","steps":["trace[1451752433] 'range keys from in-memory index tree' (duration: 210.048951ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:15:36.932126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.232562ms","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-02T18:15:36.932144Z","caller":"traceutil/trace.go:171","msg":"trace[1077660848] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1804; }","duration":"103.276773ms","start":"2026-02-02T18:15:36.828861Z","end":"2026-02-02T18:15:36.932138Z","steps":["trace[1077660848] 'range keys from in-memory index tree' (duration: 103.16415ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:16:06.156776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.362925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-02T18:16:06.156859Z","caller":"traceutil/trace.go:171","msg":"trace[422963149] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1934; }","duration":"102.468058ms","start":"2026-02-02T18:16:06.054374Z","end":"2026-02-02T18:16:06.156842Z","steps":["trace[422963149] 'range keys from in-memory index tree' (duration: 102.329124ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T18:16:06.157391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.369146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslicemirroring-controller\" ","response":"range_response_count:1 size:232"} {"level":"info","ts":"2026-02-02T18:16:06.157551Z","caller":"traceutil/trace.go:171","msg":"trace[1643016314] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslicemirroring-controller; range_end:; response_count:1; response_revision:1934; }","duration":"107.55329ms","start":"2026-02-02T18:16:06.049985Z","end":"2026-02-02T18:16:06.157538Z","steps":["trace[1643016314] 'range keys from in-memory index tree' (duration: 107.313764ms)"],"step_count":1}