{"level":"warn","ts":"2026-02-10T14:54:45.32661Z","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-10T14:54:45.326848Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.74:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.74:2380","--initial-cluster=instance=https://162.253.55.74:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.74:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.74: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-10T14:54:45.327018Z","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-10T14:54:45.327087Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.74:2380"]} {"level":"info","ts":"2026-02-10T14:54:45.327162Z","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-10T14:54:45.327971Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.74:2379"]} {"level":"info","ts":"2026-02-10T14:54:45.328202Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.74:2380"],"listen-peer-urls":["https://162.253.55.74:2380"],"advertise-client-urls":["https://162.253.55.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.74: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-10T14:54:45.334231Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.63757ms"} {"level":"info","ts":"2026-02-10T14:54:45.374467Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"30aa8136fb61a722","cluster-id":"e7ea3889c4872560"} {"level":"info","ts":"2026-02-10T14:54:45.374858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 switched to configuration voters=()"} {"level":"info","ts":"2026-02-10T14:54:45.37488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became follower at term 0"} {"level":"info","ts":"2026-02-10T14:54:45.374903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 30aa8136fb61a722 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-10T14:54:45.374929Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became follower at term 1"} {"level":"info","ts":"2026-02-10T14:54:45.374964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 switched to configuration voters=(3506757333007050530)"} {"level":"warn","ts":"2026-02-10T14:54:45.392244Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-10T14:54:45.395538Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-10T14:54:45.400866Z","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-10T14:54:45.404944Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"30aa8136fb61a722","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-10T14:54:45.405635Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"30aa8136fb61a722","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-10T14:54:45.405784Z","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-10T14:54:45.405828Z","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-10T14:54:45.405858Z","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-10T14:54:45.40647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 switched to configuration voters=(3506757333007050530)"} {"level":"info","ts":"2026-02-10T14:54:45.40658Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e7ea3889c4872560","local-member-id":"30aa8136fb61a722","added-peer-id":"30aa8136fb61a722","added-peer-peer-urls":["https://162.253.55.74:2380"]} {"level":"info","ts":"2026-02-10T14:54:45.412875Z","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-10T14:54:45.412964Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.74:2380"} {"level":"info","ts":"2026-02-10T14:54:45.413023Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.74:2380"} {"level":"info","ts":"2026-02-10T14:54:45.413963Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"30aa8136fb61a722","initial-advertise-peer-urls":["https://162.253.55.74:2380"],"listen-peer-urls":["https://162.253.55.74:2380"],"advertise-client-urls":["https://162.253.55.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-10T14:54:45.414006Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-10T14:54:46.275376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 is starting a new election at term 1"} {"level":"info","ts":"2026-02-10T14:54:46.27554Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-10T14:54:46.275616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 received MsgPreVoteResp from 30aa8136fb61a722 at term 1"} {"level":"info","ts":"2026-02-10T14:54:46.275684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became candidate at term 2"} {"level":"info","ts":"2026-02-10T14:54:46.275722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 received MsgVoteResp from 30aa8136fb61a722 at term 2"} {"level":"info","ts":"2026-02-10T14:54:46.275791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became leader at term 2"} {"level":"info","ts":"2026-02-10T14:54:46.275846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 30aa8136fb61a722 elected leader 30aa8136fb61a722 at term 2"} {"level":"info","ts":"2026-02-10T14:54:46.28552Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T14:54:46.290944Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"30aa8136fb61a722","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.74:2379]}","request-path":"/0/members/30aa8136fb61a722/attributes","cluster-id":"e7ea3889c4872560","publish-timeout":"7s"} {"level":"info","ts":"2026-02-10T14:54:46.291041Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-10T14:54:46.291418Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-10T14:54:46.293013Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.74:2379"} {"level":"info","ts":"2026-02-10T14:54:46.297017Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-10T14:54:46.297252Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-10T14:54:46.297308Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-10T14:54:46.324577Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e7ea3889c4872560","local-member-id":"30aa8136fb61a722","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T14:54:46.32706Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T14:54:46.32714Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-02-10T14:54:57.566845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.636079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-10T14:54:57.566939Z","caller":"traceutil/trace.go:171","msg":"trace[1107062849] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:335; }","duration":"120.769431ms","start":"2026-02-10T14:54:57.446153Z","end":"2026-02-10T14:54:57.566923Z","steps":["trace[1107062849] 'range keys from in-memory index tree' (duration: 120.546619ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:04.118051Z","caller":"traceutil/trace.go:171","msg":"trace[2010766701] linearizableReadLoop","detail":"{readStateIndex:412; appliedIndex:411; }","duration":"375.205694ms","start":"2026-02-10T14:55:03.742828Z","end":"2026-02-10T14:55:04.118034Z","steps":["trace[2010766701] 'read index received' (duration: 374.950241ms)","trace[2010766701] 'applied index is now lower than readState.Index' (duration: 254.683µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:04.118155Z","caller":"traceutil/trace.go:171","msg":"trace[231860141] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"380.232791ms","start":"2026-02-10T14:55:03.737916Z","end":"2026-02-10T14:55:04.118149Z","steps":["trace[231860141] 'process raft request' (duration: 379.968858ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:04.118459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.837448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-10T14:55:04.118513Z","caller":"traceutil/trace.go:171","msg":"trace[212501573] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:400; }","duration":"259.932128ms","start":"2026-02-10T14:55:03.858574Z","end":"2026-02-10T14:55:04.118506Z","steps":["trace[212501573] 'agreement among raft nodes before linearized reading' (duration: 259.847767ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:04.118736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.90908ms","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-10T14:55:04.118758Z","caller":"traceutil/trace.go:171","msg":"trace[1154313106] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:400; }","duration":"375.949991ms","start":"2026-02-10T14:55:03.742803Z","end":"2026-02-10T14:55:04.118753Z","steps":["trace[1154313106] 'agreement among raft nodes before linearized reading' (duration: 375.913761ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:04.118771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:03.742779Z","time spent":"375.988271ms","remote":"127.0.0.1:42366","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-10T14:55:04.120467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:03.737898Z","time spent":"380.273991ms","remote":"127.0.0.1:42286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5073,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:55:10.482974Z","caller":"traceutil/trace.go:171","msg":"trace[1369105855] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"209.162639ms","start":"2026-02-10T14:55:10.273797Z","end":"2026-02-10T14:55:10.48296Z","steps":["trace[1369105855] 'process raft request' (duration: 207.10057ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:13.621373Z","caller":"traceutil/trace.go:171","msg":"trace[808070620] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"149.220802ms","start":"2026-02-10T14:55:13.472133Z","end":"2026-02-10T14:55:13.621354Z","steps":["trace[808070620] 'process raft request' (duration: 111.977532ms)","trace[808070620] 'compare' (duration: 36.956888ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:13.893196Z","caller":"traceutil/trace.go:171","msg":"trace[1293044391] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"151.24603ms","start":"2026-02-10T14:55:13.741933Z","end":"2026-02-10T14:55:13.893179Z","steps":["trace[1293044391] 'process raft request' (duration: 117.691493ms)","trace[1293044391] 'compare' (duration: 33.490006ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:14.092644Z","caller":"traceutil/trace.go:171","msg":"trace[926731746] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"192.203489ms","start":"2026-02-10T14:55:13.900416Z","end":"2026-02-10T14:55:14.092619Z","steps":["trace[926731746] 'process raft request' (duration: 104.460175ms)","trace[926731746] 'compare' (duration: 87.628413ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:14.094455Z","caller":"traceutil/trace.go:171","msg":"trace[46689424] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"193.44834ms","start":"2026-02-10T14:55:13.900991Z","end":"2026-02-10T14:55:14.094439Z","steps":["trace[46689424] 'process raft request' (duration: 193.354589ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:16.179612Z","caller":"traceutil/trace.go:171","msg":"trace[244110851] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"101.585898ms","start":"2026-02-10T14:55:16.07801Z","end":"2026-02-10T14:55:16.179596Z","steps":["trace[244110851] 'process raft request' (duration: 101.465947ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:18.385834Z","caller":"traceutil/trace.go:171","msg":"trace[1260617820] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"123.670213ms","start":"2026-02-10T14:55:18.262133Z","end":"2026-02-10T14:55:18.385803Z","steps":["trace[1260617820] 'process raft request' (duration: 123.36106ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:19.677456Z","caller":"traceutil/trace.go:171","msg":"trace[1857840283] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"278.246934ms","start":"2026-02-10T14:55:19.399192Z","end":"2026-02-10T14:55:19.677439Z","steps":["trace[1857840283] 'process raft request' (duration: 278.210053ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:19.6778Z","caller":"traceutil/trace.go:171","msg":"trace[1689634134] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"281.708884ms","start":"2026-02-10T14:55:19.396081Z","end":"2026-02-10T14:55:19.67779Z","steps":["trace[1689634134] 'process raft request' (duration: 281.28457ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:19.678006Z","caller":"traceutil/trace.go:171","msg":"trace[1364763672] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"282.049406ms","start":"2026-02-10T14:55:19.395947Z","end":"2026-02-10T14:55:19.677997Z","steps":["trace[1364763672] 'process raft request' (duration: 269.379967ms)","trace[1364763672] 'compare' (duration: 11.937083ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:19.68385Z","caller":"traceutil/trace.go:171","msg":"trace[7793891] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"268.665711ms","start":"2026-02-10T14:55:19.415157Z","end":"2026-02-10T14:55:19.683823Z","steps":["trace[7793891] 'process raft request' (duration: 268.5703ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:21.026942Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12043360186798474073,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-10T14:55:21.305379Z","caller":"traceutil/trace.go:171","msg":"trace[1247384040] linearizableReadLoop","detail":"{readStateIndex:515; appliedIndex:514; }","duration":"779.050894ms","start":"2026-02-10T14:55:20.52631Z","end":"2026-02-10T14:55:21.30536Z","steps":["trace[1247384040] 'read index received' (duration: 748.003047ms)","trace[1247384040] 'applied index is now lower than readState.Index' (duration: 31.047417ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:21.305604Z","caller":"traceutil/trace.go:171","msg":"trace[818035065] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"853.405194ms","start":"2026-02-10T14:55:20.452192Z","end":"2026-02-10T14:55:21.305597Z","steps":["trace[818035065] 'process raft request' (duration: 822.160476ms)","trace[818035065] 'compare' (duration: 30.937675ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:21.305663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:20.45217Z","time spent":"853.449205ms","remote":"127.0.0.1:42366","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-10T14:55:21.305763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.453517ms","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-10T14:55:21.30578Z","caller":"traceutil/trace.go:171","msg":"trace[486851565] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:499; }","duration":"779.498878ms","start":"2026-02-10T14:55:20.526275Z","end":"2026-02-10T14:55:21.305774Z","steps":["trace[486851565] 'agreement among raft nodes before linearized reading' (duration: 779.468238ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:21.305793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:20.526256Z","time spent":"779.534068ms","remote":"127.0.0.1:42366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-10T14:55:21.305855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.29509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:21.305867Z","caller":"traceutil/trace.go:171","msg":"trace[982426155] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:499; }","duration":"121.32991ms","start":"2026-02-10T14:55:21.184533Z","end":"2026-02-10T14:55:21.305863Z","steps":["trace[982426155] 'agreement among raft nodes before linearized reading' (duration: 121.31194ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:24.724277Z","caller":"traceutil/trace.go:171","msg":"trace[1901292887] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"303.314876ms","start":"2026-02-10T14:55:24.420947Z","end":"2026-02-10T14:55:24.724262Z","steps":["trace[1901292887] 'process raft request' (duration: 303.224352ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:24.724374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:24.420938Z","time spent":"303.385229ms","remote":"127.0.0.1:42366","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-10T14:55:25.158802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.063217ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-10T14:55:25.158887Z","caller":"traceutil/trace.go:171","msg":"trace[248085368] linearizableReadLoop","detail":"{readStateIndex:523; appliedIndex:521; }","duration":"704.613248ms","start":"2026-02-10T14:55:24.454257Z","end":"2026-02-10T14:55:25.15887Z","steps":["trace[248085368] 'read index received' (duration: 269.940334ms)","trace[248085368] 'applied index is now lower than readState.Index' (duration: 434.671704ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:25.158966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.698881ms","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-10T14:55:25.158991Z","caller":"traceutil/trace.go:171","msg":"trace[2106251691] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:506; }","duration":"704.752663ms","start":"2026-02-10T14:55:24.45423Z","end":"2026-02-10T14:55:25.158983Z","steps":["trace[2106251691] 'agreement among raft nodes before linearized reading' (duration: 704.68251ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:25.159022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:24.454218Z","time spent":"704.796526ms","remote":"127.0.0.1:42366","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-10T14:55:26.450183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.499728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sh4hh\" ","response":"range_response_count:1 size:16652"} {"level":"info","ts":"2026-02-10T14:55:26.450233Z","caller":"traceutil/trace.go:171","msg":"trace[428753318] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sh4hh; range_end:; response_count:1; response_revision:512; }","duration":"102.594482ms","start":"2026-02-10T14:55:26.347627Z","end":"2026-02-10T14:55:26.450221Z","steps":["trace[428753318] 'range keys from in-memory index tree' (duration: 102.361832ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:26.450228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.954549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:26.450301Z","caller":"traceutil/trace.go:171","msg":"trace[1336196847] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:512; }","duration":"268.085444ms","start":"2026-02-10T14:55:26.182197Z","end":"2026-02-10T14:55:26.450282Z","steps":["trace[1336196847] 'range keys from in-memory index tree' (duration: 267.880965ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:26.614777Z","caller":"traceutil/trace.go:171","msg":"trace[2055697085] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"152.011386ms","start":"2026-02-10T14:55:26.462746Z","end":"2026-02-10T14:55:26.614757Z","steps":["trace[2055697085] 'process raft request' (duration: 151.912612ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:28.12296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.394608975s","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-10T14:55:28.123026Z","caller":"traceutil/trace.go:171","msg":"trace[495820936] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:513; }","duration":"1.394682058s","start":"2026-02-10T14:55:26.728328Z","end":"2026-02-10T14:55:28.12301Z","steps":["trace[495820936] 'range keys from in-memory index tree' (duration: 1.394410986s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:28.123062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:26.728269Z","time spent":"1.394785082s","remote":"127.0.0.1:42366","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-10T14:55:28.123354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"957.374557ms","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-10T14:55:28.123384Z","caller":"traceutil/trace.go:171","msg":"trace[2108713432] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:513; }","duration":"957.424589ms","start":"2026-02-10T14:55:27.16595Z","end":"2026-02-10T14:55:28.123375Z","steps":["trace[2108713432] 'range keys from in-memory index tree' (duration: 957.295513ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:28.123411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:27.165938Z","time spent":"957.46524ms","remote":"127.0.0.1:42366","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-10T14:55:28.123606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.371249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-10T14:55:28.123662Z","caller":"traceutil/trace.go:171","msg":"trace[1150926850] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:513; }","duration":"755.461432ms","start":"2026-02-10T14:55:27.368191Z","end":"2026-02-10T14:55:28.123653Z","steps":["trace[1150926850] 'range keys from in-memory index tree' (duration: 755.288165ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:28.123688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:27.368178Z","time spent":"755.503644ms","remote":"127.0.0.1:42366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-10T14:55:28.123759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"730.381361ms","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-10T14:55:28.12378Z","caller":"traceutil/trace.go:171","msg":"trace[973502839] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:513; }","duration":"730.423273ms","start":"2026-02-10T14:55:27.39335Z","end":"2026-02-10T14:55:28.123773Z","steps":["trace[973502839] 'range keys from in-memory index tree' (duration: 730.273917ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:28.123808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:27.393337Z","time spent":"730.464995ms","remote":"127.0.0.1:42366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-10T14:55:28.681064Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12043360186798474115,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-10T14:55:28.828633Z","caller":"traceutil/trace.go:171","msg":"trace[333904227] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"695.441035ms","start":"2026-02-10T14:55:28.133175Z","end":"2026-02-10T14:55:28.828616Z","steps":["trace[333904227] 'process raft request' (duration: 695.348411ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:28.828726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:28.133161Z","time spent":"695.518648ms","remote":"127.0.0.1:42366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:55:29.433422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.726376ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:55:29.433542Z","caller":"traceutil/trace.go:171","msg":"trace[1406037497] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"413.661391ms","start":"2026-02-10T14:55:29.019872Z","end":"2026-02-10T14:55:29.433533Z","steps":["trace[1406037497] 'process raft request' (duration: 413.64064ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:29.433574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:29.019854Z","time spent":"413.705183ms","remote":"127.0.0.1:42366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:55:29.433592Z","caller":"traceutil/trace.go:171","msg":"trace[401235824] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"1.299734766s","start":"2026-02-10T14:55:28.133844Z","end":"2026-02-10T14:55:29.433579Z","steps":["trace[401235824] 'process raft request' (duration: 1.125806161s)","trace[401235824] 'compare' (duration: 173.663264ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:29.43364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:28.133837Z","time spent":"1.299778837s","remote":"127.0.0.1:42366","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-10T14:55:29.433662Z","caller":"traceutil/trace.go:171","msg":"trace[1733476918] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"1.298225062s","start":"2026-02-10T14:55:28.135432Z","end":"2026-02-10T14:55:29.433657Z","steps":["trace[1733476918] 'process raft request' (duration: 1.298041354s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:29.433702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:28.135426Z","time spent":"1.298260574s","remote":"127.0.0.1:42366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:55:29.433739Z","caller":"traceutil/trace.go:171","msg":"trace[1925091615] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"1.294870002s","start":"2026-02-10T14:55:28.138865Z","end":"2026-02-10T14:55:29.433735Z","steps":["trace[1925091615] 'process raft request' (duration: 1.294629412s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:29.433758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:28.138854Z","time spent":"1.294892903s","remote":"127.0.0.1:42366","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-10T14:55:29.433825Z","caller":"traceutil/trace.go:171","msg":"trace[1545311771] linearizableReadLoop","detail":"{readStateIndex:534; appliedIndex:531; }","duration":"1.253406738s","start":"2026-02-10T14:55:28.180413Z","end":"2026-02-10T14:55:29.433819Z","steps":["trace[1545311771] 'read index received' (duration: 650.820239ms)","trace[1545311771] 'applied index is now lower than readState.Index' (duration: 602.585859ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:29.433897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.253490801s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:29.43392Z","caller":"traceutil/trace.go:171","msg":"trace[1906761310] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:518; }","duration":"1.253512812s","start":"2026-02-10T14:55:28.1804Z","end":"2026-02-10T14:55:29.433913Z","steps":["trace[1906761310] 'agreement among raft nodes before linearized reading' (duration: 1.25347983s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:29.433939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:28.180355Z","time spent":"1.253579935s","remote":"127.0.0.1:42104","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-10T14:55:29.433977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.70738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.74\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-10T14:55:29.433993Z","caller":"traceutil/trace.go:171","msg":"trace[1505143103] range","detail":"{range_begin:/registry/masterleases/162.253.55.74; range_end:; response_count:1; response_revision:518; }","duration":"125.757323ms","start":"2026-02-10T14:55:29.30823Z","end":"2026-02-10T14:55:29.433987Z","steps":["trace[1505143103] 'agreement among raft nodes before linearized reading' (duration: 125.729362ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:31.5035Z","caller":"traceutil/trace.go:171","msg":"trace[1279242035] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"135.199008ms","start":"2026-02-10T14:55:31.368288Z","end":"2026-02-10T14:55:31.503487Z","steps":["trace[1279242035] 'process raft request' (duration: 132.979778ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:32.339131Z","caller":"traceutil/trace.go:171","msg":"trace[289618781] linearizableReadLoop","detail":"{readStateIndex:552; appliedIndex:551; }","duration":"158.52454ms","start":"2026-02-10T14:55:32.180584Z","end":"2026-02-10T14:55:32.339109Z","steps":["trace[289618781] 'read index received' (duration: 158.318752ms)","trace[289618781] 'applied index is now lower than readState.Index' (duration: 204.898µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:32.339281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.675996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:32.339321Z","caller":"traceutil/trace.go:171","msg":"trace[507822680] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:534; }","duration":"158.77586ms","start":"2026-02-10T14:55:32.180533Z","end":"2026-02-10T14:55:32.339309Z","steps":["trace[507822680] 'agreement among raft nodes before linearized reading' (duration: 158.663716ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:32.339623Z","caller":"traceutil/trace.go:171","msg":"trace[2146752390] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"202.503378ms","start":"2026-02-10T14:55:32.137107Z","end":"2026-02-10T14:55:32.33961Z","steps":["trace[2146752390] 'process raft request' (duration: 201.861203ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:32.598085Z","caller":"traceutil/trace.go:171","msg":"trace[1625537098] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"207.634324ms","start":"2026-02-10T14:55:32.390433Z","end":"2026-02-10T14:55:32.598068Z","steps":["trace[1625537098] 'process raft request' (duration: 207.54904ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:32.823695Z","caller":"traceutil/trace.go:171","msg":"trace[419325478] linearizableReadLoop","detail":"{readStateIndex:555; appliedIndex:554; }","duration":"315.110922ms","start":"2026-02-10T14:55:32.50856Z","end":"2026-02-10T14:55:32.823671Z","steps":["trace[419325478] 'read index received' (duration: 89.749979ms)","trace[419325478] 'applied index is now lower than readState.Index' (duration: 225.360023ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:32.823841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.258868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-10T14:55:32.823873Z","caller":"traceutil/trace.go:171","msg":"trace[1645377167] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:537; }","duration":"315.332281ms","start":"2026-02-10T14:55:32.50853Z","end":"2026-02-10T14:55:32.823862Z","steps":["trace[1645377167] 'agreement among raft nodes before linearized reading' (duration: 315.226326ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:32.823905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:32.508514Z","time spent":"315.384003ms","remote":"127.0.0.1:42214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-02-10T14:55:32.824385Z","caller":"traceutil/trace.go:171","msg":"trace[648270323] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"381.871712ms","start":"2026-02-10T14:55:32.442495Z","end":"2026-02-10T14:55:32.824366Z","steps":["trace[648270323] 'process raft request' (duration: 333.447655ms)","trace[648270323] 'compare' (duration: 47.615635ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:32.824467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:32.442479Z","time spent":"381.937255ms","remote":"127.0.0.1:42286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17314,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:55:33.185768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.838748ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:55:33.185824Z","caller":"traceutil/trace.go:171","msg":"trace[2012576179] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"134.26088ms","start":"2026-02-10T14:55:33.051553Z","end":"2026-02-10T14:55:33.185814Z","steps":["trace[2012576179] 'process raft request' (duration: 33.322488ms)","trace[2012576179] 'compare' (duration: 100.693172ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:33.188214Z","caller":"traceutil/trace.go:171","msg":"trace[2104175135] linearizableReadLoop","detail":"{readStateIndex:560; appliedIndex:558; }","duration":"133.974829ms","start":"2026-02-10T14:55:33.05423Z","end":"2026-02-10T14:55:33.188205Z","steps":["trace[2104175135] 'read index received' (duration: 30.653542ms)","trace[2104175135] 'applied index is now lower than readState.Index' (duration: 103.320727ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:33.188382Z","caller":"traceutil/trace.go:171","msg":"trace[1259809741] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"134.942588ms","start":"2026-02-10T14:55:33.053433Z","end":"2026-02-10T14:55:33.188376Z","steps":["trace[1259809741] 'process raft request' (duration: 134.734999ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:33.18857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.349254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:33.188711Z","caller":"traceutil/trace.go:171","msg":"trace[1415324492] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:0; response_revision:542; }","duration":"134.51508ms","start":"2026-02-10T14:55:33.054187Z","end":"2026-02-10T14:55:33.188702Z","steps":["trace[1415324492] 'agreement among raft nodes before linearized reading' (duration: 134.348994ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:33.188841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.160696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:33.188948Z","caller":"traceutil/trace.go:171","msg":"trace[1262790952] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:542; }","duration":"134.276411ms","start":"2026-02-10T14:55:33.054666Z","end":"2026-02-10T14:55:33.188942Z","steps":["trace[1262790952] 'agreement among raft nodes before linearized reading' (duration: 134.160276ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:33.189165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.36028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:33.18927Z","caller":"traceutil/trace.go:171","msg":"trace[1401375200] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:542; }","duration":"100.474814ms","start":"2026-02-10T14:55:33.088788Z","end":"2026-02-10T14:55:33.189262Z","steps":["trace[1401375200] 'agreement among raft nodes before linearized reading' (duration: 100.365869ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:33.189387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.234292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:33.189452Z","caller":"traceutil/trace.go:171","msg":"trace[691828420] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:542; }","duration":"104.304986ms","start":"2026-02-10T14:55:33.085142Z","end":"2026-02-10T14:55:33.189447Z","steps":["trace[691828420] 'agreement among raft nodes before linearized reading' (duration: 104.232003ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:33.189556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.42184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:33.189622Z","caller":"traceutil/trace.go:171","msg":"trace[44496169] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:542; }","duration":"104.509904ms","start":"2026-02-10T14:55:33.085107Z","end":"2026-02-10T14:55:33.189617Z","steps":["trace[44496169] 'agreement among raft nodes before linearized reading' (duration: 104.437881ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:33.189733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.353897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:33.189805Z","caller":"traceutil/trace.go:171","msg":"trace[724025493] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:542; }","duration":"127.427059ms","start":"2026-02-10T14:55:33.06236Z","end":"2026-02-10T14:55:33.189787Z","steps":["trace[724025493] 'agreement among raft nodes before linearized reading' (duration: 127.361607ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:33.189912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.423166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:33.189983Z","caller":"traceutil/trace.go:171","msg":"trace[1751378981] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:542; }","duration":"134.50387ms","start":"2026-02-10T14:55:33.055474Z","end":"2026-02-10T14:55:33.189978Z","steps":["trace[1751378981] 'agreement among raft nodes before linearized reading' (duration: 134.424447ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:33.190091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.003099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:33.190182Z","caller":"traceutil/trace.go:171","msg":"trace[2050663432] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:542; }","duration":"135.102154ms","start":"2026-02-10T14:55:33.055075Z","end":"2026-02-10T14:55:33.190177Z","steps":["trace[2050663432] 'agreement among raft nodes before linearized reading' (duration: 135.00316ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:33.384564Z","caller":"traceutil/trace.go:171","msg":"trace[337792598] linearizableReadLoop","detail":"{readStateIndex:562; appliedIndex:561; }","duration":"169.098438ms","start":"2026-02-10T14:55:33.215445Z","end":"2026-02-10T14:55:33.384543Z","steps":["trace[337792598] 'read index received' (duration: 56.745084ms)","trace[337792598] 'applied index is now lower than readState.Index' (duration: 112.352564ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:33.384658Z","caller":"traceutil/trace.go:171","msg":"trace[228574340] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"187.408062ms","start":"2026-02-10T14:55:33.197233Z","end":"2026-02-10T14:55:33.384642Z","steps":["trace[228574340] 'process raft request' (duration: 158.602743ms)","trace[228574340] 'compare' (duration: 28.617091ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:33.384766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.313336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:33.384795Z","caller":"traceutil/trace.go:171","msg":"trace[873114639] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:544; }","duration":"169.373089ms","start":"2026-02-10T14:55:33.215414Z","end":"2026-02-10T14:55:33.384787Z","steps":["trace[873114639] 'agreement among raft nodes before linearized reading' (duration: 169.303086ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:33.460817Z","caller":"traceutil/trace.go:171","msg":"trace[736405801] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"184.448434ms","start":"2026-02-10T14:55:33.276355Z","end":"2026-02-10T14:55:33.460803Z","steps":["trace[736405801] 'process raft request' (duration: 184.366921ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:33.870564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.247734ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:55:33.870695Z","caller":"traceutil/trace.go:171","msg":"trace[119310883] linearizableReadLoop","detail":"{readStateIndex:564; appliedIndex:563; }","duration":"486.073832ms","start":"2026-02-10T14:55:33.38461Z","end":"2026-02-10T14:55:33.870683Z","steps":["trace[119310883] 'read index received' (duration: 76.189412ms)","trace[119310883] 'applied index is now lower than readState.Index' (duration: 409.88375ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:33.870742Z","caller":"traceutil/trace.go:171","msg":"trace[1235971887] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"486.202768ms","start":"2026-02-10T14:55:33.384532Z","end":"2026-02-10T14:55:33.870735Z","steps":["trace[1235971887] 'process raft request' (duration: 271.738086ms)","trace[1235971887] 'compare' (duration: 214.110748ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:33.870778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:33.384519Z","time spent":"486.239259ms","remote":"127.0.0.1:42192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":743,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:55:33.870922Z","caller":"traceutil/trace.go:171","msg":"trace[1004969024] transaction","detail":"{read_only:false; number_of_response:0; response_revision:546; }","duration":"482.073095ms","start":"2026-02-10T14:55:33.388843Z","end":"2026-02-10T14:55:33.870916Z","steps":["trace[1004969024] 'process raft request' (duration: 481.799124ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:33.870952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:33.388782Z","time spent":"482.154497ms","remote":"127.0.0.1:42620","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T14:55:33.87108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.102612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sh4hh\" ","response":"range_response_count:1 size:17329"} {"level":"info","ts":"2026-02-10T14:55:33.871121Z","caller":"traceutil/trace.go:171","msg":"trace[816817989] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sh4hh; range_end:; response_count:1; response_revision:546; }","duration":"489.177035ms","start":"2026-02-10T14:55:33.381934Z","end":"2026-02-10T14:55:33.871111Z","steps":["trace[816817989] 'agreement among raft nodes before linearized reading' (duration: 489.03293ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:33.871144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:33.381919Z","time spent":"489.219467ms","remote":"127.0.0.1:42286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17352,"request content":"key:\"/registry/pods/kube-system/cilium-sh4hh\" "} {"level":"info","ts":"2026-02-10T14:55:33.872779Z","caller":"traceutil/trace.go:171","msg":"trace[828710364] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"255.61747ms","start":"2026-02-10T14:55:33.617149Z","end":"2026-02-10T14:55:33.872767Z","steps":["trace[828710364] 'process raft request' (duration: 255.546097ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:34.391944Z","caller":"traceutil/trace.go:171","msg":"trace[1815565873] linearizableReadLoop","detail":"{readStateIndex:567; appliedIndex:566; }","duration":"521.212677ms","start":"2026-02-10T14:55:33.870713Z","end":"2026-02-10T14:55:34.391925Z","steps":["trace[1815565873] 'read index received' (duration: 11.860129ms)","trace[1815565873] 'applied index is now lower than readState.Index' (duration: 509.351528ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:34.393945Z","caller":"traceutil/trace.go:171","msg":"trace[1606420280] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"577.733101ms","start":"2026-02-10T14:55:33.816199Z","end":"2026-02-10T14:55:34.393932Z","steps":["trace[1606420280] 'process raft request' (duration: 575.008364ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:34.394186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:33.81618Z","time spent":"577.804293ms","remote":"127.0.0.1:42156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T14:55:34.394552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.106027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-10T14:55:34.394583Z","caller":"traceutil/trace.go:171","msg":"trace[984381032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:548; }","duration":"797.166779ms","start":"2026-02-10T14:55:33.597409Z","end":"2026-02-10T14:55:34.394576Z","steps":["trace[984381032] 'agreement among raft nodes before linearized reading' (duration: 797.023954ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:34.394798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:33.597394Z","time spent":"797.394788ms","remote":"127.0.0.1:42366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-10T14:55:34.395152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.938389ms","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-10T14:55:34.39518Z","caller":"traceutil/trace.go:171","msg":"trace[310040948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:548; }","duration":"797.981201ms","start":"2026-02-10T14:55:33.597192Z","end":"2026-02-10T14:55:34.395173Z","steps":["trace[310040948] 'agreement among raft nodes before linearized reading' (duration: 797.906688ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:34.3952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:33.597187Z","time spent":"798.008151ms","remote":"127.0.0.1:42366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-10T14:55:34.395514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.331224ms","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-10T14:55:34.395543Z","caller":"traceutil/trace.go:171","msg":"trace[547409633] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:548; }","duration":"798.395247ms","start":"2026-02-10T14:55:33.59714Z","end":"2026-02-10T14:55:34.395536Z","steps":["trace[547409633] 'agreement among raft nodes before linearized reading' (duration: 798.317164ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:34.395613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:33.597121Z","time spent":"798.48523ms","remote":"127.0.0.1:42366","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-10T14:55:34.395849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"980.56513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:34.395875Z","caller":"traceutil/trace.go:171","msg":"trace[1585815488] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:548; }","duration":"980.627813ms","start":"2026-02-10T14:55:33.41524Z","end":"2026-02-10T14:55:34.395868Z","steps":["trace[1585815488] 'agreement among raft nodes before linearized reading' (duration: 980.587461ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:34.396028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:33.415221Z","time spent":"980.79778ms","remote":"127.0.0.1:42156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"info","ts":"2026-02-10T14:55:34.448379Z","caller":"traceutil/trace.go:171","msg":"trace[767874716] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"230.986154ms","start":"2026-02-10T14:55:34.217313Z","end":"2026-02-10T14:55:34.448299Z","steps":["trace[767874716] 'process raft request' (duration: 230.941552ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:34.450143Z","caller":"traceutil/trace.go:171","msg":"trace[578158493] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"566.784773ms","start":"2026-02-10T14:55:33.882281Z","end":"2026-02-10T14:55:34.449066Z","steps":["trace[578158493] 'process raft request' (duration: 565.724102ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:34.45027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:33.882261Z","time spent":"567.96912ms","remote":"127.0.0.1:42620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:55:34.450476Z","caller":"traceutil/trace.go:171","msg":"trace[1171334666] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"568.109355ms","start":"2026-02-10T14:55:33.882359Z","end":"2026-02-10T14:55:34.450468Z","steps":["trace[1171334666] 'process raft request' (duration: 565.742772ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:34.450549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:33.882354Z","time spent":"568.165167ms","remote":"127.0.0.1:42156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9296,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:55:34.450712Z","caller":"traceutil/trace.go:171","msg":"trace[215968658] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"568.154497ms","start":"2026-02-10T14:55:33.88255Z","end":"2026-02-10T14:55:34.450704Z","steps":["trace[215968658] 'process raft request' (duration: 565.627048ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:34.450791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:33.882545Z","time spent":"568.22449ms","remote":"127.0.0.1:42286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17396,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:55:34.450895Z","caller":"traceutil/trace.go:171","msg":"trace[2040675108] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"427.21981ms","start":"2026-02-10T14:55:34.023667Z","end":"2026-02-10T14:55:34.450887Z","steps":["trace[2040675108] 'process raft request' (duration: 424.552316ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:34.450954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:34.023645Z","time spent":"427.291882ms","remote":"127.0.0.1:42156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T14:55:34.451749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.145591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v2.cilium.io\" ","response":"range_response_count:1 size:947"} {"level":"info","ts":"2026-02-10T14:55:34.451807Z","caller":"traceutil/trace.go:171","msg":"trace[913456399] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v2.cilium.io; range_end:; response_count:1; response_revision:553; }","duration":"579.328888ms","start":"2026-02-10T14:55:33.87247Z","end":"2026-02-10T14:55:34.451798Z","steps":["trace[913456399] 'agreement among raft nodes before linearized reading' (duration: 579.211103ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:34.451845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:33.872458Z","time spent":"579.38067ms","remote":"127.0.0.1:42620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":970,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/v2.cilium.io\" "} {"level":"warn","ts":"2026-02-10T14:55:34.451951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.673948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:34.451993Z","caller":"traceutil/trace.go:171","msg":"trace[798283657] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:553; }","duration":"269.766581ms","start":"2026-02-10T14:55:34.182221Z","end":"2026-02-10T14:55:34.451987Z","steps":["trace[798283657] 'agreement among raft nodes before linearized reading' (duration: 269.711089ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:34.72998Z","caller":"traceutil/trace.go:171","msg":"trace[1776721455] linearizableReadLoop","detail":"{readStateIndex:577; appliedIndex:572; }","duration":"263.697764ms","start":"2026-02-10T14:55:34.466262Z","end":"2026-02-10T14:55:34.72996Z","steps":["trace[1776721455] 'read index received' (duration: 22.75865ms)","trace[1776721455] 'applied index is now lower than readState.Index' (duration: 240.938344ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:34.730065Z","caller":"traceutil/trace.go:171","msg":"trace[22274952] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"262.171144ms","start":"2026-02-10T14:55:34.467886Z","end":"2026-02-10T14:55:34.730057Z","steps":["trace[22274952] 'process raft request' (duration: 261.827011ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:34.730198Z","caller":"traceutil/trace.go:171","msg":"trace[1543726692] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"261.945945ms","start":"2026-02-10T14:55:34.468246Z","end":"2026-02-10T14:55:34.730192Z","steps":["trace[1543726692] 'process raft request' (duration: 261.605651ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:34.730282Z","caller":"traceutil/trace.go:171","msg":"trace[610165942] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"113.463968ms","start":"2026-02-10T14:55:34.616813Z","end":"2026-02-10T14:55:34.730277Z","steps":["trace[610165942] 'process raft request' (duration: 113.095274ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:34.730408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.133781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-67twk\" ","response":"range_response_count:1 size:4818"} {"level":"info","ts":"2026-02-10T14:55:34.730434Z","caller":"traceutil/trace.go:171","msg":"trace[9652723] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-67twk; range_end:; response_count:1; response_revision:560; }","duration":"264.221404ms","start":"2026-02-10T14:55:34.466206Z","end":"2026-02-10T14:55:34.730428Z","steps":["trace[9652723] 'agreement among raft nodes before linearized reading' (duration: 263.831129ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:35.311279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.306192ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:55:35.311884Z","caller":"traceutil/trace.go:171","msg":"trace[1369154820] linearizableReadLoop","detail":"{readStateIndex:587; appliedIndex:582; }","duration":"350.731446ms","start":"2026-02-10T14:55:34.961139Z","end":"2026-02-10T14:55:35.31187Z","steps":["trace[1369154820] 'read index received' (duration: 257.23953ms)","trace[1369154820] 'applied index is now lower than readState.Index' (duration: 93.491286ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:35.312184Z","caller":"traceutil/trace.go:171","msg":"trace[935725758] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"568.592118ms","start":"2026-02-10T14:55:34.74358Z","end":"2026-02-10T14:55:35.312173Z","steps":["trace[935725758] 'process raft request' (duration: 130.329448ms)","trace[935725758] 'compare' (duration: 436.438339ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:35.312407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:34.74355Z","time spent":"568.828326ms","remote":"127.0.0.1:42156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4156,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:55:35.312664Z","caller":"traceutil/trace.go:171","msg":"trace[1698862045] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"564.123562ms","start":"2026-02-10T14:55:34.748531Z","end":"2026-02-10T14:55:35.312655Z","steps":["trace[1698862045] 'process raft request' (duration: 563.198146ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:35.312834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:34.748523Z","time spent":"564.218046ms","remote":"127.0.0.1:42156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4318,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:55:35.313088Z","caller":"traceutil/trace.go:171","msg":"trace[315301951] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"556.803046ms","start":"2026-02-10T14:55:34.756276Z","end":"2026-02-10T14:55:35.313079Z","steps":["trace[315301951] 'process raft request' (duration: 555.500025ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:35.313184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:34.756253Z","time spent":"556.91121ms","remote":"127.0.0.1:42192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":700,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:55:35.313673Z","caller":"traceutil/trace.go:171","msg":"trace[698931365] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"535.405508ms","start":"2026-02-10T14:55:34.778257Z","end":"2026-02-10T14:55:35.313662Z","steps":["trace[698931365] 'process raft request' (duration: 533.559867ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:35.313764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:34.778241Z","time spent":"535.479531ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4365,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:55:35.314044Z","caller":"traceutil/trace.go:171","msg":"trace[1780845998] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"474.755247ms","start":"2026-02-10T14:55:34.839278Z","end":"2026-02-10T14:55:35.314033Z","steps":["trace[1780845998] 'process raft request' (duration: 472.572232ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:35.314157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:34.839248Z","time spent":"474.887962ms","remote":"127.0.0.1:42156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T14:55:35.314396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.260054ms","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-10T14:55:35.314481Z","caller":"traceutil/trace.go:171","msg":"trace[1188015320] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:567; }","duration":"353.382639ms","start":"2026-02-10T14:55:34.961088Z","end":"2026-02-10T14:55:35.314471Z","steps":["trace[1188015320] 'agreement among raft nodes before linearized reading' (duration: 353.233543ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:35.314546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:34.961065Z","time spent":"353.471182ms","remote":"127.0.0.1:42366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-10T14:55:35.350194Z","caller":"traceutil/trace.go:171","msg":"trace[680659856] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"330.12532ms","start":"2026-02-10T14:55:35.019892Z","end":"2026-02-10T14:55:35.350017Z","steps":["trace[680659856] 'process raft request' (duration: 330.046287ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:35.355081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:35.019868Z","time spent":"335.145915ms","remote":"127.0.0.1:42156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:55:35.676334Z","caller":"traceutil/trace.go:171","msg":"trace[112367656] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"418.393175ms","start":"2026-02-10T14:55:35.257888Z","end":"2026-02-10T14:55:35.676281Z","steps":["trace[112367656] 'process raft request' (duration: 336.367422ms)","trace[112367656] 'compare' (duration: 81.611127ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:35.676434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:35.257864Z","time spent":"418.52667ms","remote":"127.0.0.1:42156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:55:35.677774Z","caller":"traceutil/trace.go:171","msg":"trace[1464684996] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"348.9966ms","start":"2026-02-10T14:55:35.32877Z","end":"2026-02-10T14:55:35.677766Z","steps":["trace[1464684996] 'process raft request' (duration: 347.259912ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:35.677821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:35.328752Z","time spent":"349.042372ms","remote":"127.0.0.1:42548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:55:35.683868Z","caller":"traceutil/trace.go:171","msg":"trace[1707076110] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"352.129161ms","start":"2026-02-10T14:55:35.331732Z","end":"2026-02-10T14:55:35.683861Z","steps":["trace[1707076110] 'process raft request' (duration: 344.515227ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:35.683965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:35.331718Z","time spent":"352.170042ms","remote":"127.0.0.1:42366","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-10T14:55:35.684263Z","caller":"traceutil/trace.go:171","msg":"trace[1469328341] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"343.266619ms","start":"2026-02-10T14:55:35.34099Z","end":"2026-02-10T14:55:35.684257Z","steps":["trace[1469328341] 'process raft request' (duration: 338.351119ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:35.684396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:35.340971Z","time spent":"343.308421ms","remote":"127.0.0.1:42156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4165,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:55:35.684585Z","caller":"traceutil/trace.go:171","msg":"trace[1286699585] linearizableReadLoop","detail":"{readStateIndex:589; appliedIndex:588; }","duration":"372.590724ms","start":"2026-02-10T14:55:35.311988Z","end":"2026-02-10T14:55:35.684578Z","steps":["trace[1286699585] 'read index received' (duration: 39.230349ms)","trace[1286699585] 'applied index is now lower than readState.Index' (duration: 333.359925ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:35.684676Z","caller":"traceutil/trace.go:171","msg":"trace[1962701936] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"343.641923ms","start":"2026-02-10T14:55:35.341029Z","end":"2026-02-10T14:55:35.684671Z","steps":["trace[1962701936] 'process raft request' (duration: 342.814061ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:35.684752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:35.341021Z","time spent":"343.671085ms","remote":"127.0.0.1:42156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24220,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:55:35.684977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.956206ms","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-10T14:55:35.684998Z","caller":"traceutil/trace.go:171","msg":"trace[1118212628] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:573; }","duration":"494.978367ms","start":"2026-02-10T14:55:35.190015Z","end":"2026-02-10T14:55:35.684993Z","steps":["trace[1118212628] 'agreement among raft nodes before linearized reading' (duration: 494.905594ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:35.685061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:35.189956Z","time spent":"495.099432ms","remote":"127.0.0.1:42366","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-10T14:55:35.686226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.472554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:35.686245Z","caller":"traceutil/trace.go:171","msg":"trace[1524276119] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:573; }","duration":"505.530025ms","start":"2026-02-10T14:55:35.18071Z","end":"2026-02-10T14:55:35.68624Z","steps":["trace[1524276119] 'agreement among raft nodes before linearized reading' (duration: 505.501974ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:35.68632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:35.180686Z","time spent":"505.629179ms","remote":"127.0.0.1:42104","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-10T14:55:35.751218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.404141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sh4hh\" ","response":"range_response_count:1 size:17411"} {"level":"info","ts":"2026-02-10T14:55:35.75127Z","caller":"traceutil/trace.go:171","msg":"trace[88586927] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sh4hh; range_end:; response_count:1; response_revision:574; }","duration":"216.496635ms","start":"2026-02-10T14:55:35.534767Z","end":"2026-02-10T14:55:35.751264Z","steps":["trace[88586927] 'agreement among raft nodes before linearized reading' (duration: 216.316638ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:35.751058Z","caller":"traceutil/trace.go:171","msg":"trace[1510577516] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"214.472846ms","start":"2026-02-10T14:55:35.536569Z","end":"2026-02-10T14:55:35.751042Z","steps":["trace[1510577516] 'process raft request' (duration: 214.237617ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:35.751567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.072462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-02-10T14:55:35.751584Z","caller":"traceutil/trace.go:171","msg":"trace[1596885508] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:574; }","duration":"137.093093ms","start":"2026-02-10T14:55:35.614485Z","end":"2026-02-10T14:55:35.751578Z","steps":["trace[1596885508] 'agreement among raft nodes before linearized reading' (duration: 136.936037ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:35.757596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.780741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-02-10T14:55:35.757647Z","caller":"traceutil/trace.go:171","msg":"trace[1646139720] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:574; }","duration":"341.874135ms","start":"2026-02-10T14:55:35.41576Z","end":"2026-02-10T14:55:35.757635Z","steps":["trace[1646139720] 'agreement among raft nodes before linearized reading' (duration: 341.721619ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:35.75806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:35.415741Z","time spent":"342.27806ms","remote":"127.0.0.1:42156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":1,"response size":5609,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" "} {"level":"warn","ts":"2026-02-10T14:55:36.139646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.911538ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:55:36.139718Z","caller":"traceutil/trace.go:171","msg":"trace[1183158709] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"380.215621ms","start":"2026-02-10T14:55:35.75949Z","end":"2026-02-10T14:55:36.139705Z","steps":["trace[1183158709] 'process raft request' (duration: 83.187968ms)","trace[1183158709] 'compare' (duration: 296.818655ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:36.139758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:35.759478Z","time spent":"380.260963ms","remote":"127.0.0.1:42156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10353,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:55:36.478489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.714979ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:55:36.478786Z","caller":"traceutil/trace.go:171","msg":"trace[1331636491] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"333.467308ms","start":"2026-02-10T14:55:36.145308Z","end":"2026-02-10T14:55:36.478776Z","steps":["trace[1331636491] 'process raft request' (duration: 333.444167ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:36.47882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:36.145292Z","time spent":"333.512279ms","remote":"127.0.0.1:42156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4059,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:55:36.479033Z","caller":"traceutil/trace.go:171","msg":"trace[137580313] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"700.269208ms","start":"2026-02-10T14:55:35.778758Z","end":"2026-02-10T14:55:36.479027Z","steps":["trace[137580313] 'process raft request' (duration: 504.969976ms)","trace[137580313] 'compare' (duration: 194.591955ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:36.47906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:35.778742Z","time spent":"700.30243ms","remote":"127.0.0.1:42156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:55:36.479159Z","caller":"traceutil/trace.go:171","msg":"trace[169568007] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"676.704857ms","start":"2026-02-10T14:55:35.80245Z","end":"2026-02-10T14:55:36.479155Z","steps":["trace[169568007] 'process raft request' (duration: 676.094943ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:36.479184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:35.802433Z","time spent":"676.736587ms","remote":"127.0.0.1:42286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17651,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:55:36.479234Z","caller":"traceutil/trace.go:171","msg":"trace[1595057859] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"638.572861ms","start":"2026-02-10T14:55:35.840657Z","end":"2026-02-10T14:55:36.47923Z","steps":["trace[1595057859] 'process raft request' (duration: 638.014149ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:36.479254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:35.84064Z","time spent":"638.604522ms","remote":"127.0.0.1:42156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:55:36.479306Z","caller":"traceutil/trace.go:171","msg":"trace[1424456836] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:596; }","duration":"435.559834ms","start":"2026-02-10T14:55:36.04374Z","end":"2026-02-10T14:55:36.4793Z","steps":["trace[1424456836] 'read index received' (duration: 240.016353ms)","trace[1424456836] 'applied index is now lower than readState.Index' (duration: 195.542921ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:36.479516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.776752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"} {"level":"info","ts":"2026-02-10T14:55:36.479531Z","caller":"traceutil/trace.go:171","msg":"trace[803368527] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:580; }","duration":"435.814754ms","start":"2026-02-10T14:55:36.043711Z","end":"2026-02-10T14:55:36.479526Z","steps":["trace[803368527] 'agreement among raft nodes before linearized reading' (duration: 435.752102ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:36.479544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:36.043698Z","time spent":"435.842935ms","remote":"127.0.0.1:42156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4356,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "} {"level":"warn","ts":"2026-02-10T14:55:36.479605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.93954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:36.479617Z","caller":"traceutil/trace.go:171","msg":"trace[84432839] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"296.982512ms","start":"2026-02-10T14:55:36.18263Z","end":"2026-02-10T14:55:36.479613Z","steps":["trace[84432839] 'agreement among raft nodes before linearized reading' (duration: 296.964832ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:36.479817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.438917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-02-10T14:55:36.479831Z","caller":"traceutil/trace.go:171","msg":"trace[726294430] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:580; }","duration":"264.493828ms","start":"2026-02-10T14:55:36.215333Z","end":"2026-02-10T14:55:36.479827Z","steps":["trace[726294430] 'agreement among raft nodes before linearized reading' (duration: 264.455257ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:37.071665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.728052ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:55:37.071855Z","caller":"traceutil/trace.go:171","msg":"trace[1326366574] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:601; }","duration":"457.33977ms","start":"2026-02-10T14:55:36.614506Z","end":"2026-02-10T14:55:37.071845Z","steps":["trace[1326366574] 'read index received' (duration: 2.362501ms)","trace[1326366574] 'applied index is now lower than readState.Index' (duration: 454.976679ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:37.071907Z","caller":"traceutil/trace.go:171","msg":"trace[1839818881] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"549.61266ms","start":"2026-02-10T14:55:36.522288Z","end":"2026-02-10T14:55:37.071901Z","steps":["trace[1839818881] 'process raft request' (duration: 549.473785ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:37.071935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:36.522281Z","time spent":"549.637371ms","remote":"127.0.0.1:42366","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-10T14:55:37.072034Z","caller":"traceutil/trace.go:171","msg":"trace[915023365] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"523.132527ms","start":"2026-02-10T14:55:36.548897Z","end":"2026-02-10T14:55:37.072029Z","steps":["trace[915023365] 'process raft request' (duration: 522.893828ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:37.072047Z","caller":"traceutil/trace.go:171","msg":"trace[1588735887] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"557.836764ms","start":"2026-02-10T14:55:36.514199Z","end":"2026-02-10T14:55:37.072035Z","steps":["trace[1588735887] 'process raft request' (duration: 92.685866ms)","trace[1588735887] 'compare' (duration: 464.65541ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:37.072058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:36.548881Z","time spent":"523.163299ms","remote":"127.0.0.1:42366","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-10T14:55:37.072098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:36.514185Z","time spent":"557.887767ms","remote":"127.0.0.1:42156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5153,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:55:37.072116Z","caller":"traceutil/trace.go:171","msg":"trace[1564960649] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"512.268671ms","start":"2026-02-10T14:55:36.559843Z","end":"2026-02-10T14:55:37.072112Z","steps":["trace[1564960649] 'process raft request' (duration: 511.96414ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:37.072134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:36.559827Z","time spent":"512.298933ms","remote":"127.0.0.1:42192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":712,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:55:37.072189Z","caller":"traceutil/trace.go:171","msg":"trace[877511017] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"554.235797ms","start":"2026-02-10T14:55:36.517947Z","end":"2026-02-10T14:55:37.072183Z","steps":["trace[877511017] 'process raft request' (duration: 553.777109ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:37.072208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.702574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-02-10T14:55:37.072223Z","caller":"traceutil/trace.go:171","msg":"trace[1309352752] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:586; }","duration":"457.741315ms","start":"2026-02-10T14:55:36.614476Z","end":"2026-02-10T14:55:37.072218Z","steps":["trace[1309352752] 'agreement among raft nodes before linearized reading' (duration: 457.712584ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:37.072223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:36.517936Z","time spent":"554.267918ms","remote":"127.0.0.1:42156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10362,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:55:37.072237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:36.614464Z","time spent":"457.769656ms","remote":"127.0.0.1:42156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":10400,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-10T14:55:37.072316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.61481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4074"} {"level":"info","ts":"2026-02-10T14:55:37.072329Z","caller":"traceutil/trace.go:171","msg":"trace[1902739723] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:586; }","duration":"256.656271ms","start":"2026-02-10T14:55:36.815668Z","end":"2026-02-10T14:55:37.072324Z","steps":["trace[1902739723] 'agreement among raft nodes before linearized reading' (duration: 256.605429ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:37.330215Z","caller":"traceutil/trace.go:171","msg":"trace[179682806] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:607; }","duration":"147.70993ms","start":"2026-02-10T14:55:37.182491Z","end":"2026-02-10T14:55:37.330201Z","steps":["trace[179682806] 'read index received' (duration: 135.374163ms)","trace[179682806] 'applied index is now lower than readState.Index' (duration: 12.335277ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:37.330339Z","caller":"traceutil/trace.go:171","msg":"trace[1674864638] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"247.974594ms","start":"2026-02-10T14:55:37.082358Z","end":"2026-02-10T14:55:37.330333Z","steps":["trace[1674864638] 'process raft request' (duration: 235.552024ms)","trace[1674864638] 'compare' (duration: 12.028045ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:37.330421Z","caller":"traceutil/trace.go:171","msg":"trace[593604240] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"245.975298ms","start":"2026-02-10T14:55:37.084441Z","end":"2026-02-10T14:55:37.330417Z","steps":["trace[593604240] 'process raft request' (duration: 245.728099ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:37.330487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.98352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:37.330502Z","caller":"traceutil/trace.go:171","msg":"trace[692305796] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:589; }","duration":"148.035892ms","start":"2026-02-10T14:55:37.182462Z","end":"2026-02-10T14:55:37.330498Z","steps":["trace[692305796] 'agreement among raft nodes before linearized reading' (duration: 147.997691ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:37.330571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.625395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13220"} {"level":"info","ts":"2026-02-10T14:55:37.330583Z","caller":"traceutil/trace.go:171","msg":"trace[1503749195] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:589; }","duration":"106.654776ms","start":"2026-02-10T14:55:37.223924Z","end":"2026-02-10T14:55:37.330579Z","steps":["trace[1503749195] 'agreement among raft nodes before linearized reading' (duration: 106.629205ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:37.90836Z","caller":"traceutil/trace.go:171","msg":"trace[1222602854] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"162.859842ms","start":"2026-02-10T14:55:37.745486Z","end":"2026-02-10T14:55:37.908346Z","steps":["trace[1222602854] 'read index received' (duration: 161.033523ms)","trace[1222602854] 'applied index is now lower than readState.Index' (duration: 1.825689ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:37.908521Z","caller":"traceutil/trace.go:171","msg":"trace[1776827458] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"210.153693ms","start":"2026-02-10T14:55:37.698362Z","end":"2026-02-10T14:55:37.908515Z","steps":["trace[1776827458] 'process raft request' (duration: 208.23648ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:37.908948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.451474ms","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-10T14:55:37.909018Z","caller":"traceutil/trace.go:171","msg":"trace[1408030105] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:598; }","duration":"163.549268ms","start":"2026-02-10T14:55:37.745461Z","end":"2026-02-10T14:55:37.909011Z","steps":["trace[1408030105] 'agreement among raft nodes before linearized reading' (duration: 163.306409ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:37.914035Z","caller":"traceutil/trace.go:171","msg":"trace[373596377] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"107.376743ms","start":"2026-02-10T14:55:37.806648Z","end":"2026-02-10T14:55:37.914025Z","steps":["trace[373596377] 'process raft request' (duration: 107.147934ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.613798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.435812ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-10T14:55:46.289324Z","caller":"traceutil/trace.go:171","msg":"trace[763549696] linearizableReadLoop","detail":"{readStateIndex:686; appliedIndex:685; }","duration":"195.445719ms","start":"2026-02-10T14:55:46.093857Z","end":"2026-02-10T14:55:46.289303Z","steps":["trace[763549696] 'read index received' (duration: 195.252822ms)","trace[763549696] 'applied index is now lower than readState.Index' (duration: 191.937µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:46.289453Z","caller":"traceutil/trace.go:171","msg":"trace[2129051763] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"213.889192ms","start":"2026-02-10T14:55:46.07555Z","end":"2026-02-10T14:55:46.289439Z","steps":["trace[2129051763] 'process raft request' (duration: 213.625983ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:46.289742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.873183ms","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-10T14:55:46.29034Z","caller":"traceutil/trace.go:171","msg":"trace[2025007669] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:663; }","duration":"196.519386ms","start":"2026-02-10T14:55:46.093813Z","end":"2026-02-10T14:55:46.290333Z","steps":["trace[2025007669] 'agreement among raft nodes before linearized reading' (duration: 195.673957ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:46.290509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.151868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:46.291474Z","caller":"traceutil/trace.go:171","msg":"trace[653909939] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:663; }","duration":"109.151222ms","start":"2026-02-10T14:55:46.182312Z","end":"2026-02-10T14:55:46.291463Z","steps":["trace[653909939] 'agreement among raft nodes before linearized reading' (duration: 108.156608ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:46.421093Z","caller":"traceutil/trace.go:171","msg":"trace[990470303] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"111.98385ms","start":"2026-02-10T14:55:46.309091Z","end":"2026-02-10T14:55:46.421075Z","steps":["trace[990470303] 'process raft request' (duration: 98.999383ms)","trace[990470303] 'compare' (duration: 12.921214ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:47.445334Z","caller":"traceutil/trace.go:171","msg":"trace[1542577005] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"261.429395ms","start":"2026-02-10T14:55:47.183886Z","end":"2026-02-10T14:55:47.445315Z","steps":["trace[1542577005] 'process raft request' (duration: 261.29328ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:47.614964Z","caller":"traceutil/trace.go:171","msg":"trace[1918728042] linearizableReadLoop","detail":"{readStateIndex:692; appliedIndex:691; }","duration":"400.050921ms","start":"2026-02-10T14:55:47.214896Z","end":"2026-02-10T14:55:47.614947Z","steps":["trace[1918728042] 'read index received' (duration: 231.275169ms)","trace[1918728042] 'applied index is now lower than readState.Index' (duration: 168.775092ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:47.614991Z","caller":"traceutil/trace.go:171","msg":"trace[2127352797] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"428.119076ms","start":"2026-02-10T14:55:47.186844Z","end":"2026-02-10T14:55:47.614963Z","steps":["trace[2127352797] 'process raft request' (duration: 350.787025ms)","trace[2127352797] 'compare' (duration: 77.234887ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:47.615105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:47.186836Z","time spent":"428.207358ms","remote":"127.0.0.1:42192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":780,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T14:55:47.615142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.228237ms","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-10T14:55:47.615162Z","caller":"traceutil/trace.go:171","msg":"trace[1805241259] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:669; }","duration":"400.294329ms","start":"2026-02-10T14:55:47.214861Z","end":"2026-02-10T14:55:47.615155Z","steps":["trace[1805241259] 'agreement among raft nodes before linearized reading' (duration: 400.171195ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:47.615193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:47.214848Z","time spent":"400.33914ms","remote":"127.0.0.1:42366","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-10T14:55:47.615399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.365478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-10T14:55:47.615421Z","caller":"traceutil/trace.go:171","msg":"trace[763446672] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:669; }","duration":"183.468142ms","start":"2026-02-10T14:55:47.431946Z","end":"2026-02-10T14:55:47.615414Z","steps":["trace[763446672] 'agreement among raft nodes before linearized reading' (duration: 183.41849ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:47.944632Z","caller":"traceutil/trace.go:171","msg":"trace[809389627] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"321.29469ms","start":"2026-02-10T14:55:47.623322Z","end":"2026-02-10T14:55:47.944616Z","steps":["trace[809389627] 'process raft request' (duration: 321.258109ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:47.944738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:47.623304Z","time spent":"321.376753ms","remote":"127.0.0.1:42286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4974,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:55:47.944656Z","caller":"traceutil/trace.go:171","msg":"trace[439202817] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"321.375573ms","start":"2026-02-10T14:55:47.623256Z","end":"2026-02-10T14:55:47.944632Z","steps":["trace[439202817] 'process raft request' (duration: 263.635908ms)","trace[439202817] 'compare' (duration: 57.59756ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:47.945164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:47.62325Z","time spent":"321.786237ms","remote":"127.0.0.1:42366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:55:48.042987Z","caller":"traceutil/trace.go:171","msg":"trace[818780069] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"396.379381ms","start":"2026-02-10T14:55:47.646592Z","end":"2026-02-10T14:55:48.042972Z","steps":["trace[818780069] 'process raft request' (duration: 396.289828ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:48.043089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:47.646577Z","time spent":"396.471935ms","remote":"127.0.0.1:42192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":722,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:55:48.05646Z","caller":"traceutil/trace.go:171","msg":"trace[1228942840] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"104.058993ms","start":"2026-02-10T14:55:47.952384Z","end":"2026-02-10T14:55:48.056443Z","steps":["trace[1228942840] 'process raft request' (duration: 102.204201ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:48.056777Z","caller":"traceutil/trace.go:171","msg":"trace[98905976] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"102.200269ms","start":"2026-02-10T14:55:47.95457Z","end":"2026-02-10T14:55:48.056771Z","steps":["trace[98905976] 'process raft request' (duration: 101.847537ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:48.266514Z","caller":"traceutil/trace.go:171","msg":"trace[1204453343] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"178.642866ms","start":"2026-02-10T14:55:48.087837Z","end":"2026-02-10T14:55:48.26648Z","steps":["trace[1204453343] 'process raft request' (duration: 178.516931ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:48.382817Z","caller":"traceutil/trace.go:171","msg":"trace[349762107] linearizableReadLoop","detail":"{readStateIndex:701; appliedIndex:700; }","duration":"199.86377ms","start":"2026-02-10T14:55:48.182932Z","end":"2026-02-10T14:55:48.382796Z","steps":["trace[349762107] 'read index received' (duration: 84.389522ms)","trace[349762107] 'applied index is now lower than readState.Index' (duration: 115.473528ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:48.382894Z","caller":"traceutil/trace.go:171","msg":"trace[23023752] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"294.876459ms","start":"2026-02-10T14:55:48.088012Z","end":"2026-02-10T14:55:48.382888Z","steps":["trace[23023752] 'process raft request' (duration: 245.728074ms)","trace[23023752] 'compare' (duration: 48.962639ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:48.383099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.136279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:48.383118Z","caller":"traceutil/trace.go:171","msg":"trace[112814406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:678; }","duration":"200.205512ms","start":"2026-02-10T14:55:48.182906Z","end":"2026-02-10T14:55:48.383111Z","steps":["trace[112814406] 'agreement among raft nodes before linearized reading' (duration: 200.126899ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:48.384412Z","caller":"traceutil/trace.go:171","msg":"trace[967973807] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"101.679293ms","start":"2026-02-10T14:55:48.282727Z","end":"2026-02-10T14:55:48.384406Z","steps":["trace[967973807] 'process raft request' (duration: 101.403724ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:48.384518Z","caller":"traceutil/trace.go:171","msg":"trace[241768323] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"101.736676ms","start":"2026-02-10T14:55:48.282776Z","end":"2026-02-10T14:55:48.384513Z","steps":["trace[241768323] 'process raft request' (duration: 101.398615ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:48.384619Z","caller":"traceutil/trace.go:171","msg":"trace[249668844] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"101.812948ms","start":"2026-02-10T14:55:48.282801Z","end":"2026-02-10T14:55:48.384614Z","steps":["trace[249668844] 'process raft request' (duration: 101.394134ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:48.655946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.501716ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:55:48.656423Z","caller":"traceutil/trace.go:171","msg":"trace[930687450] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"186.585232ms","start":"2026-02-10T14:55:48.469815Z","end":"2026-02-10T14:55:48.656401Z","steps":["trace[930687450] 'process raft request' (duration: 33.529199ms)","trace[930687450] 'compare' (duration: 152.250896ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:48.819721Z","caller":"traceutil/trace.go:171","msg":"trace[757713898] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"140.970497ms","start":"2026-02-10T14:55:48.678732Z","end":"2026-02-10T14:55:48.819703Z","steps":["trace[757713898] 'process raft request' (duration: 140.862783ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:48.870138Z","caller":"traceutil/trace.go:171","msg":"trace[1442043961] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"191.300282ms","start":"2026-02-10T14:55:48.678821Z","end":"2026-02-10T14:55:48.870122Z","steps":["trace[1442043961] 'process raft request' (duration: 191.191828ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:49.025421Z","caller":"traceutil/trace.go:171","msg":"trace[578888382] linearizableReadLoop","detail":"{readStateIndex:712; appliedIndex:709; }","duration":"198.924962ms","start":"2026-02-10T14:55:48.826474Z","end":"2026-02-10T14:55:49.025399Z","steps":["trace[578888382] 'read index received' (duration: 43.498835ms)","trace[578888382] 'applied index is now lower than readState.Index' (duration: 155.425646ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:49.025571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.065886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-j9tcc\" ","response":"range_response_count:1 size:5022"} {"level":"info","ts":"2026-02-10T14:55:49.025592Z","caller":"traceutil/trace.go:171","msg":"trace[886593086] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-j9tcc; range_end:; response_count:1; response_revision:690; }","duration":"199.127309ms","start":"2026-02-10T14:55:48.826458Z","end":"2026-02-10T14:55:49.025585Z","steps":["trace[886593086] 'agreement among raft nodes before linearized reading' (duration: 199.015415ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:49.025687Z","caller":"traceutil/trace.go:171","msg":"trace[1771561819] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"199.632535ms","start":"2026-02-10T14:55:48.826029Z","end":"2026-02-10T14:55:49.025662Z","steps":["trace[1771561819] 'process raft request' (duration: 170.407938ms)","trace[1771561819] 'compare' (duration: 28.823304ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:49.025774Z","caller":"traceutil/trace.go:171","msg":"trace[2038897910] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"199.335295ms","start":"2026-02-10T14:55:48.826433Z","end":"2026-02-10T14:55:49.025768Z","steps":["trace[2038897910] 'process raft request' (duration: 198.912511ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:49.025861Z","caller":"traceutil/trace.go:171","msg":"trace[198279829] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"167.340908ms","start":"2026-02-10T14:55:48.858514Z","end":"2026-02-10T14:55:49.025855Z","steps":["trace[198279829] 'process raft request' (duration: 166.860102ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:49.301387Z","caller":"traceutil/trace.go:171","msg":"trace[137805733] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"103.80652ms","start":"2026-02-10T14:55:49.197562Z","end":"2026-02-10T14:55:49.301369Z","steps":["trace[137805733] 'process raft request' (duration: 60.140485ms)","trace[137805733] 'compare' (duration: 43.590962ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:49.435243Z","caller":"traceutil/trace.go:171","msg":"trace[1638452247] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"126.276439ms","start":"2026-02-10T14:55:49.308944Z","end":"2026-02-10T14:55:49.435221Z","steps":["trace[1638452247] 'process raft request' (duration: 126.215057ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:49.436109Z","caller":"traceutil/trace.go:171","msg":"trace[1758658482] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"129.3328ms","start":"2026-02-10T14:55:49.306641Z","end":"2026-02-10T14:55:49.435974Z","steps":["trace[1758658482] 'process raft request' (duration: 128.374788ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:49.436486Z","caller":"traceutil/trace.go:171","msg":"trace[277731223] linearizableReadLoop","detail":"{readStateIndex:719; appliedIndex:718; }","duration":"129.236887ms","start":"2026-02-10T14:55:49.307237Z","end":"2026-02-10T14:55:49.436474Z","steps":["trace[277731223] 'read index received' (duration: 127.706755ms)","trace[277731223] 'applied index is now lower than readState.Index' (duration: 1.528911ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:49.437054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.799506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-hlsss\" ","response":"range_response_count:1 size:4811"} {"level":"info","ts":"2026-02-10T14:55:49.437428Z","caller":"traceutil/trace.go:171","msg":"trace[679614797] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-hlsss; range_end:; response_count:1; response_revision:697; }","duration":"130.198879ms","start":"2026-02-10T14:55:49.307215Z","end":"2026-02-10T14:55:49.437414Z","steps":["trace[679614797] 'agreement among raft nodes before linearized reading' (duration: 129.736133ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:49.438009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.161784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.74\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-10T14:55:49.438506Z","caller":"traceutil/trace.go:171","msg":"trace[267997513] range","detail":"{range_begin:/registry/masterleases/162.253.55.74; range_end:; response_count:1; response_revision:697; }","duration":"129.664592ms","start":"2026-02-10T14:55:49.308825Z","end":"2026-02-10T14:55:49.43849Z","steps":["trace[267997513] 'agreement among raft nodes before linearized reading' (duration: 129.104413ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:49.620596Z","caller":"traceutil/trace.go:171","msg":"trace[399196224] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"163.906942ms","start":"2026-02-10T14:55:49.456644Z","end":"2026-02-10T14:55:49.620551Z","steps":["trace[399196224] 'process raft request' (duration: 122.571874ms)","trace[399196224] 'compare' (duration: 41.235775ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:50.92944Z","caller":"traceutil/trace.go:171","msg":"trace[1527590618] linearizableReadLoop","detail":"{readStateIndex:743; appliedIndex:742; }","duration":"268.393654ms","start":"2026-02-10T14:55:50.661032Z","end":"2026-02-10T14:55:50.929426Z","steps":["trace[1527590618] 'read index received' (duration: 268.296121ms)","trace[1527590618] 'applied index is now lower than readState.Index' (duration: 96.993µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:50.929515Z","caller":"traceutil/trace.go:171","msg":"trace[1223011116] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"331.32985ms","start":"2026-02-10T14:55:50.598178Z","end":"2026-02-10T14:55:50.929508Z","steps":["trace[1223011116] 'process raft request' (duration: 331.185225ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:50.929569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:50.598165Z","time spent":"331.367992ms","remote":"127.0.0.1:42192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":723,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T14:55:50.929785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.752016ms","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-10T14:55:50.92982Z","caller":"traceutil/trace.go:171","msg":"trace[1640570841] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:719; }","duration":"268.791237ms","start":"2026-02-10T14:55:50.661023Z","end":"2026-02-10T14:55:50.929814Z","steps":["trace[1640570841] 'agreement among raft nodes before linearized reading' (duration: 268.673493ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:51.07689Z","caller":"traceutil/trace.go:171","msg":"trace[481837728] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"143.094367ms","start":"2026-02-10T14:55:50.93378Z","end":"2026-02-10T14:55:51.076875Z","steps":["trace[481837728] 'process raft request' (duration: 143.068976ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:51.077104Z","caller":"traceutil/trace.go:171","msg":"trace[2066313676] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"143.575153ms","start":"2026-02-10T14:55:50.93352Z","end":"2026-02-10T14:55:51.077096Z","steps":["trace[2066313676] 'process raft request' (duration: 119.766075ms)","trace[2066313676] 'compare' (duration: 23.356463ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:52.237738Z","caller":"traceutil/trace.go:171","msg":"trace[797263494] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"232.803597ms","start":"2026-02-10T14:55:52.00491Z","end":"2026-02-10T14:55:52.237713Z","steps":["trace[797263494] 'process raft request' (duration: 232.325562ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:52.708142Z","caller":"traceutil/trace.go:171","msg":"trace[2090638015] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"190.584161ms","start":"2026-02-10T14:55:52.517519Z","end":"2026-02-10T14:55:52.708103Z","steps":["trace[2090638015] 'process raft request' (duration: 168.744715ms)","trace[2090638015] 'compare' (duration: 21.65624ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:56.065297Z","caller":"traceutil/trace.go:171","msg":"trace[2036613070] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"391.355778ms","start":"2026-02-10T14:55:55.673922Z","end":"2026-02-10T14:55:56.065278Z","steps":["trace[2036613070] 'process raft request' (duration: 391.234074ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:56.065415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:55.673911Z","time spent":"391.444881ms","remote":"127.0.0.1:42366","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-10T14:55:57.167543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"906.590611ms","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-10T14:55:57.167594Z","caller":"traceutil/trace.go:171","msg":"trace[986689292] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:741; }","duration":"906.680384ms","start":"2026-02-10T14:55:56.260902Z","end":"2026-02-10T14:55:57.167583Z","steps":["trace[986689292] 'range keys from in-memory index tree' (duration: 906.463377ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:57.16762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:56.260884Z","time spent":"906.730646ms","remote":"127.0.0.1:42366","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-10T14:55:57.167855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.396237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:57.167878Z","caller":"traceutil/trace.go:171","msg":"trace[2099811233] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:741; }","duration":"681.437648ms","start":"2026-02-10T14:55:56.486433Z","end":"2026-02-10T14:55:57.167871Z","steps":["trace[2099811233] 'range keys from in-memory index tree' (duration: 681.358125ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:57.167897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:56.486421Z","time spent":"681.471178ms","remote":"127.0.0.1:59798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 "} {"level":"warn","ts":"2026-02-10T14:55:57.167993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.287573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:57.168011Z","caller":"traceutil/trace.go:171","msg":"trace[1544578947] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:741; }","duration":"681.305714ms","start":"2026-02-10T14:55:56.4867Z","end":"2026-02-10T14:55:57.168005Z","steps":["trace[1544578947] 'range keys from in-memory index tree' (duration: 681.267162ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:57.168028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:56.486685Z","time spent":"681.337714ms","remote":"127.0.0.1:59798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 "} {"level":"warn","ts":"2026-02-10T14:55:57.168107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.296644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:57.168126Z","caller":"traceutil/trace.go:171","msg":"trace[668188283] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:741; }","duration":"681.344564ms","start":"2026-02-10T14:55:56.486776Z","end":"2026-02-10T14:55:57.168121Z","steps":["trace[668188283] 'count revisions from in-memory index tree' (duration: 681.228422ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:57.168143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:56.486759Z","time spent":"681.379136ms","remote":"127.0.0.1:59798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-02-10T14:55:57.168338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.106696ms","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-10T14:55:57.168818Z","caller":"traceutil/trace.go:171","msg":"trace[1276836002] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:741; }","duration":"567.604781ms","start":"2026-02-10T14:55:56.601201Z","end":"2026-02-10T14:55:57.168806Z","steps":["trace[1276836002] 'range keys from in-memory index tree' (duration: 567.042954ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:57.168844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:56.601187Z","time spent":"567.648193ms","remote":"127.0.0.1:42366","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-10T14:55:57.169364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.914932ms","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-10T14:55:57.169551Z","caller":"traceutil/trace.go:171","msg":"trace[1086627694] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:741; }","duration":"221.109838ms","start":"2026-02-10T14:55:56.948432Z","end":"2026-02-10T14:55:57.169542Z","steps":["trace[1086627694] 'count revisions from in-memory index tree' (duration: 220.890632ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:57.169784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.380797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:57.169918Z","caller":"traceutil/trace.go:171","msg":"trace[797084666] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:741; }","duration":"221.534741ms","start":"2026-02-10T14:55:56.948373Z","end":"2026-02-10T14:55:57.169908Z","steps":["trace[797084666] 'range keys from in-memory index tree' (duration: 221.299864ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:57.170206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.995733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:57.170329Z","caller":"traceutil/trace.go:171","msg":"trace[136971324] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:741; }","duration":"220.127828ms","start":"2026-02-10T14:55:56.950191Z","end":"2026-02-10T14:55:57.170279Z","steps":["trace[136971324] 'range keys from in-memory index tree' (duration: 219.971093ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:57.170649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.561574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:57.170797Z","caller":"traceutil/trace.go:171","msg":"trace[1974380130] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:741; }","duration":"213.718988ms","start":"2026-02-10T14:55:56.957064Z","end":"2026-02-10T14:55:57.170783Z","steps":["trace[1974380130] 'range keys from in-memory index tree' (duration: 213.465251ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:57.171061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.025018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:57.171185Z","caller":"traceutil/trace.go:171","msg":"trace[1871821044] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:741; }","duration":"214.169722ms","start":"2026-02-10T14:55:56.957005Z","end":"2026-02-10T14:55:57.171174Z","steps":["trace[1871821044] 'range keys from in-memory index tree' (duration: 213.894084ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:57.171495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.364319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:57.171631Z","caller":"traceutil/trace.go:171","msg":"trace[26305294] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:741; }","duration":"214.508633ms","start":"2026-02-10T14:55:56.957115Z","end":"2026-02-10T14:55:57.171623Z","steps":["trace[26305294] 'count revisions from in-memory index tree' (duration: 214.343248ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:57.171959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.93513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:57.172052Z","caller":"traceutil/trace.go:171","msg":"trace[1137780751] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:741; }","duration":"200.065494ms","start":"2026-02-10T14:55:56.971978Z","end":"2026-02-10T14:55:57.172044Z","steps":["trace[1137780751] 'range keys from in-memory index tree' (duration: 199.905689ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:57.172423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.486797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:57.172507Z","caller":"traceutil/trace.go:171","msg":"trace[433230473] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:741; }","duration":"200.586631ms","start":"2026-02-10T14:55:56.971902Z","end":"2026-02-10T14:55:57.172489Z","steps":["trace[433230473] 'range keys from in-memory index tree' (duration: 200.350603ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:57.172823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.771696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:57.172937Z","caller":"traceutil/trace.go:171","msg":"trace[1670475884] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:741; }","duration":"200.886049ms","start":"2026-02-10T14:55:56.972042Z","end":"2026-02-10T14:55:57.172928Z","steps":["trace[1670475884] 'count revisions from in-memory index tree' (duration: 200.742956ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:57.173254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.57248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:57.173309Z","caller":"traceutil/trace.go:171","msg":"trace[1368077173] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:741; }","duration":"191.657213ms","start":"2026-02-10T14:55:56.981643Z","end":"2026-02-10T14:55:57.1733Z","steps":["trace[1368077173] 'count revisions from in-memory index tree' (duration: 191.524898ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:57.352246Z","caller":"traceutil/trace.go:171","msg":"trace[196943497] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"165.338066ms","start":"2026-02-10T14:55:57.186886Z","end":"2026-02-10T14:55:57.352224Z","steps":["trace[196943497] 'process raft request' (duration: 165.218492ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:57.352534Z","caller":"traceutil/trace.go:171","msg":"trace[1687469072] linearizableReadLoop","detail":"{readStateIndex:768; appliedIndex:768; }","duration":"165.281434ms","start":"2026-02-10T14:55:57.187243Z","end":"2026-02-10T14:55:57.352524Z","steps":["trace[1687469072] 'read index received' (duration: 165.276984ms)","trace[1687469072] 'applied index is now lower than readState.Index' (duration: 3.79µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:57.352804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.547382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:57.353Z","caller":"traceutil/trace.go:171","msg":"trace[786250035] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:742; }","duration":"165.755998ms","start":"2026-02-10T14:55:57.187221Z","end":"2026-02-10T14:55:57.352977Z","steps":["trace[786250035] 'agreement among raft nodes before linearized reading' (duration: 165.432628ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:57.397714Z","caller":"traceutil/trace.go:171","msg":"trace[657486777] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"204.728297ms","start":"2026-02-10T14:55:57.192972Z","end":"2026-02-10T14:55:57.397701Z","steps":["trace[657486777] 'process raft request' (duration: 194.533653ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:57.398379Z","caller":"traceutil/trace.go:171","msg":"trace[1910170846] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"205.342566ms","start":"2026-02-10T14:55:57.19303Z","end":"2026-02-10T14:55:57.398372Z","steps":["trace[1910170846] 'process raft request' (duration: 204.537161ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:57.398518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.248044ms","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-10T14:55:57.398539Z","caller":"traceutil/trace.go:171","msg":"trace[177752171] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:744; }","duration":"194.314326ms","start":"2026-02-10T14:55:57.204219Z","end":"2026-02-10T14:55:57.398534Z","steps":["trace[177752171] 'agreement among raft nodes before linearized reading' (duration: 194.229114ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:57.51022Z","caller":"traceutil/trace.go:171","msg":"trace[351333614] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"108.832198ms","start":"2026-02-10T14:55:57.40137Z","end":"2026-02-10T14:55:57.510202Z","steps":["trace[351333614] 'process raft request' (duration: 106.861117ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:23.662034Z","caller":"traceutil/trace.go:171","msg":"trace[1307101136] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"117.424176ms","start":"2026-02-10T14:56:23.544594Z","end":"2026-02-10T14:56:23.662018Z","steps":["trace[1307101136] 'process raft request' (duration: 116.243357ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:31.691314Z","caller":"traceutil/trace.go:171","msg":"trace[174720156] linearizableReadLoop","detail":"{readStateIndex:877; appliedIndex:876; }","duration":"105.148829ms","start":"2026-02-10T14:56:31.586148Z","end":"2026-02-10T14:56:31.691296Z","steps":["trace[174720156] 'read index received' (duration: 104.992906ms)","trace[174720156] 'applied index is now lower than readState.Index' (duration: 155.083µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:56:31.691589Z","caller":"traceutil/trace.go:171","msg":"trace[526154285] transaction","detail":"{read_only:false; response_revision:844; number_of_response:1; }","duration":"210.927314ms","start":"2026-02-10T14:56:31.480649Z","end":"2026-02-10T14:56:31.691576Z","steps":["trace[526154285] 'process raft request' (duration: 210.544845ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:31.69185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.683982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-10T14:56:31.691884Z","caller":"traceutil/trace.go:171","msg":"trace[1860528087] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:844; }","duration":"105.728923ms","start":"2026-02-10T14:56:31.586144Z","end":"2026-02-10T14:56:31.691872Z","steps":["trace[1860528087] 'agreement among raft nodes before linearized reading' (duration: 105.61791ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:33.93311Z","caller":"traceutil/trace.go:171","msg":"trace[946452863] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"157.743355ms","start":"2026-02-10T14:56:33.775346Z","end":"2026-02-10T14:56:33.933089Z","steps":["trace[946452863] 'process raft request' (duration: 145.005619ms)","trace[946452863] 'compare' (duration: 12.606333ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:56:33.933314Z","caller":"traceutil/trace.go:171","msg":"trace[818757903] transaction","detail":"{read_only:false; response_revision:852; number_of_response:1; }","duration":"154.721107ms","start":"2026-02-10T14:56:33.778568Z","end":"2026-02-10T14:56:33.933289Z","steps":["trace[818757903] 'process raft request' (duration: 154.488622ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:46.009675Z","caller":"traceutil/trace.go:171","msg":"trace[290385823] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"128.894635ms","start":"2026-02-10T14:56:45.880766Z","end":"2026-02-10T14:56:46.00966Z","steps":["trace[290385823] 'process raft request' (duration: 128.821393ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:46.00968Z","caller":"traceutil/trace.go:171","msg":"trace[1284791463] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"146.396756ms","start":"2026-02-10T14:56:45.863267Z","end":"2026-02-10T14:56:46.009664Z","steps":["trace[1284791463] 'process raft request' (duration: 145.17027ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:46.010372Z","caller":"traceutil/trace.go:171","msg":"trace[103991818] linearizableReadLoop","detail":"{readStateIndex:946; appliedIndex:945; }","duration":"129.738203ms","start":"2026-02-10T14:56:45.880609Z","end":"2026-02-10T14:56:46.010347Z","steps":["trace[103991818] 'read index received' (duration: 127.835914ms)","trace[103991818] 'applied index is now lower than readState.Index' (duration: 1.901389ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:56:46.01063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.881305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:1536"} {"level":"info","ts":"2026-02-10T14:56:46.01071Z","caller":"traceutil/trace.go:171","msg":"trace[1887013277] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:911; }","duration":"130.12945ms","start":"2026-02-10T14:56:45.88057Z","end":"2026-02-10T14:56:46.0107Z","steps":["trace[1887013277] 'agreement among raft nodes before linearized reading' (duration: 129.893505ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:46.01093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.783799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-10T14:56:46.010981Z","caller":"traceutil/trace.go:171","msg":"trace[364750694] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:911; }","duration":"122.876051ms","start":"2026-02-10T14:56:45.8881Z","end":"2026-02-10T14:56:46.010976Z","steps":["trace[364750694] 'agreement among raft nodes before linearized reading' (duration: 122.780739ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:49.97067Z","caller":"traceutil/trace.go:171","msg":"trace[804086253] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"130.875285ms","start":"2026-02-10T14:56:49.839777Z","end":"2026-02-10T14:56:49.970652Z","steps":["trace[804086253] 'process raft request' (duration: 130.766723ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:50.116091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.506223ms","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-10T14:56:50.116186Z","caller":"traceutil/trace.go:171","msg":"trace[1721531170] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:926; }","duration":"102.633775ms","start":"2026-02-10T14:56:50.013537Z","end":"2026-02-10T14:56:50.11617Z","steps":["trace[1721531170] 'range keys from in-memory index tree' (duration: 102.494563ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:50.743085Z","caller":"traceutil/trace.go:171","msg":"trace[31245223] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"273.605401ms","start":"2026-02-10T14:56:50.469463Z","end":"2026-02-10T14:56:50.743069Z","steps":["trace[31245223] 'process raft request' (duration: 273.5176ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:52.232527Z","caller":"traceutil/trace.go:171","msg":"trace[511715917] linearizableReadLoop","detail":"{readStateIndex:969; appliedIndex:968; }","duration":"182.439666ms","start":"2026-02-10T14:56:52.050072Z","end":"2026-02-10T14:56:52.232512Z","steps":["trace[511715917] 'read index received' (duration: 182.324734ms)","trace[511715917] 'applied index is now lower than readState.Index' (duration: 112.952µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:56:52.232594Z","caller":"traceutil/trace.go:171","msg":"trace[959241429] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"255.851743ms","start":"2026-02-10T14:56:51.976737Z","end":"2026-02-10T14:56:52.232588Z","steps":["trace[959241429] 'process raft request' (duration: 255.672929ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:52.232695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.605471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:56:52.232712Z","caller":"traceutil/trace.go:171","msg":"trace[549728077] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:932; }","duration":"182.644131ms","start":"2026-02-10T14:56:52.050063Z","end":"2026-02-10T14:56:52.232707Z","steps":["trace[549728077] 'agreement among raft nodes before linearized reading' (duration: 182.59366ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:52.260892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.019849ms","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-10T14:56:52.260945Z","caller":"traceutil/trace.go:171","msg":"trace[537893680] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:932; }","duration":"119.096181ms","start":"2026-02-10T14:56:52.141835Z","end":"2026-02-10T14:56:52.260932Z","steps":["trace[537893680] 'agreement among raft nodes before linearized reading' (duration: 91.06853ms)","trace[537893680] 'range keys from in-memory index tree' (duration: 27.910699ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:56:56.879881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.629725ms","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-10T14:56:56.87994Z","caller":"traceutil/trace.go:171","msg":"trace[825012397] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:953; }","duration":"105.740898ms","start":"2026-02-10T14:56:56.774184Z","end":"2026-02-10T14:56:56.879925Z","steps":["trace[825012397] 'range keys from in-memory index tree' (duration: 104.794419ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:57.026713Z","caller":"traceutil/trace.go:171","msg":"trace[1273721697] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"142.635292ms","start":"2026-02-10T14:56:56.884056Z","end":"2026-02-10T14:56:57.026691Z","steps":["trace[1273721697] 'process raft request' (duration: 142.465169ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:57:04.763072Z","caller":"traceutil/trace.go:171","msg":"trace[85327076] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"478.018113ms","start":"2026-02-10T14:57:04.285037Z","end":"2026-02-10T14:57:04.763055Z","steps":["trace[85327076] 'process raft request' (duration: 477.908561ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:04.764583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:04.285021Z","time spent":"479.482359ms","remote":"127.0.0.1:42366","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-10T14:57:04.765902Z","caller":"traceutil/trace.go:171","msg":"trace[1928573940] linearizableReadLoop","detail":"{readStateIndex:1016; appliedIndex:1016; }","duration":"433.245314ms","start":"2026-02-10T14:57:04.332648Z","end":"2026-02-10T14:57:04.765893Z","steps":["trace[1928573940] 'read index received' (duration: 433.241774ms)","trace[1928573940] 'applied index is now lower than readState.Index' (duration: 2.99µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:57:04.766479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.828115ms","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-10T14:57:04.766846Z","caller":"traceutil/trace.go:171","msg":"trace[211652048] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:976; }","duration":"434.235052ms","start":"2026-02-10T14:57:04.332601Z","end":"2026-02-10T14:57:04.766836Z","steps":["trace[211652048] 'agreement among raft nodes before linearized reading' (duration: 433.57532ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:04.766992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:04.332582Z","time spent":"434.375995ms","remote":"127.0.0.1:42366","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-10T14:57:04.772898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.428594ms","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-10T14:57:04.773043Z","caller":"traceutil/trace.go:171","msg":"trace[951365090] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:977; }","duration":"106.598707ms","start":"2026-02-10T14:57:04.666434Z","end":"2026-02-10T14:57:04.773032Z","steps":["trace[951365090] 'agreement among raft nodes before linearized reading' (duration: 106.422363ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:06.786715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.389834498s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:57:06.786856Z","caller":"traceutil/trace.go:171","msg":"trace[1026355120] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"2.006323825s","start":"2026-02-10T14:57:04.780523Z","end":"2026-02-10T14:57:06.786846Z","steps":["trace[1026355120] 'process raft request' (duration: 616.295643ms)","trace[1026355120] 'compare' (duration: 1.389677266s)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:57:06.786928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:04.780508Z","time spent":"2.006383916s","remote":"127.0.0.1:42366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:57:06.786801Z","caller":"traceutil/trace.go:171","msg":"trace[446894932] linearizableReadLoop","detail":"{readStateIndex:1021; appliedIndex:1020; }","duration":"1.479445362s","start":"2026-02-10T14:57:05.307341Z","end":"2026-02-10T14:57:06.786786Z","steps":["trace[446894932] 'read index received' (duration: 89.38716ms)","trace[446894932] 'applied index is now lower than readState.Index' (duration: 1.390057212s)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:57:06.788509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.481163633s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-10T14:57:06.788644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.480223636s","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-10T14:57:06.788698Z","caller":"traceutil/trace.go:171","msg":"trace[148640331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:980; }","duration":"1.480303087s","start":"2026-02-10T14:57:05.308388Z","end":"2026-02-10T14:57:06.788691Z","steps":["trace[148640331] 'agreement among raft nodes before linearized reading' (duration: 1.480204706s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:06.788727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:05.308374Z","time spent":"1.480347718s","remote":"127.0.0.1:42366","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":"info","ts":"2026-02-10T14:57:06.788824Z","caller":"traceutil/trace.go:171","msg":"trace[1886188283] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:980; }","duration":"1.481271165s","start":"2026-02-10T14:57:05.307294Z","end":"2026-02-10T14:57:06.788565Z","steps":["trace[1886188283] 'agreement among raft nodes before linearized reading' (duration: 1.481179583s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:06.78902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:05.307281Z","time spent":"1.481642492s","remote":"127.0.0.1:42104","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-10T14:57:07.300549Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12043360186798475218,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:57:07.801037Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12043360186798475218,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:57:08.401643Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12043360186798475218,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:57:08.799404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999656152s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-10T14:57:08.799539Z","caller":"traceutil/trace.go:171","msg":"trace[1822786286] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999785364s","start":"2026-02-10T14:57:06.799707Z","end":"2026-02-10T14:57:08.799493Z","steps":["trace[1822786286] 'agreement among raft nodes before linearized reading' (duration: 1.999667052s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:08.799847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:06.799701Z","time spent":"2.000067859s","remote":"127.0.0.1:42104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/10 14:57:08 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-10T14:57:08.90217Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12043360186798475218,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:57:09.402868Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12043360186798475218,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:57:09.903888Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12043360186798475218,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:57:10.401293Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.602635379s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-10T14:57:10.403561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.471483ms","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-10T14:57:10.403646Z","caller":"traceutil/trace.go:171","msg":"trace[1444185311] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:982; }","duration":"390.576235ms","start":"2026-02-10T14:57:10.013059Z","end":"2026-02-10T14:57:10.403635Z","steps":["trace[1444185311] 'range keys from in-memory index tree' (duration: 390.460063ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:57:10.404685Z","caller":"traceutil/trace.go:171","msg":"trace[538139024] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"3.609167616s","start":"2026-02-10T14:57:06.795508Z","end":"2026-02-10T14:57:10.404676Z","steps":["trace[538139024] 'process raft request' (duration: 3.606268384s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:10.404767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:06.795501Z","time spent":"3.609204766s","remote":"127.0.0.1:42366","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-10T14:57:10.409235Z","caller":"traceutil/trace.go:171","msg":"trace[408731728] linearizableReadLoop","detail":"{readStateIndex:1025; appliedIndex:1023; }","duration":"3.609495039s","start":"2026-02-10T14:57:06.799723Z","end":"2026-02-10T14:57:10.409218Z","steps":["trace[408731728] 'read index received' (duration: 3.601984836s)","trace[408731728] 'applied index is now lower than readState.Index' (duration: 7.509513ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:57:10.40942Z","caller":"traceutil/trace.go:171","msg":"trace[1703865297] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"3.613796387s","start":"2026-02-10T14:57:06.795614Z","end":"2026-02-10T14:57:10.40941Z","steps":["trace[1703865297] 'process raft request' (duration: 3.608499494s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:10.409498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:06.79561Z","time spent":"3.613830398s","remote":"127.0.0.1:42366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:57:10.409575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.614417869s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-10T14:57:10.409666Z","caller":"traceutil/trace.go:171","msg":"trace[1831373686] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:984; }","duration":"1.614553781s","start":"2026-02-10T14:57:08.795102Z","end":"2026-02-10T14:57:10.409656Z","steps":["trace[1831373686] 'agreement among raft nodes before linearized reading' (duration: 1.614381568s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:10.409693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:08.795081Z","time spent":"1.614606543s","remote":"127.0.0.1:42366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-10T14:57:10.409826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.609042843s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:57:10.409842Z","caller":"traceutil/trace.go:171","msg":"trace[2147337025] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:984; }","duration":"1.609110515s","start":"2026-02-10T14:57:08.800724Z","end":"2026-02-10T14:57:10.409835Z","steps":["trace[2147337025] 'agreement among raft nodes before linearized reading' (duration: 1.609087574s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:10.409855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:08.800683Z","time spent":"1.609168645s","remote":"127.0.0.1:42120","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-10T14:57:10.40987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.6077338s","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-10T14:57:10.409896Z","caller":"traceutil/trace.go:171","msg":"trace[984337982] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:984; }","duration":"1.607807721s","start":"2026-02-10T14:57:08.802081Z","end":"2026-02-10T14:57:10.409889Z","steps":["trace[984337982] 'agreement among raft nodes before linearized reading' (duration: 1.607698299s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:10.40992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:08.802071Z","time spent":"1.607844522s","remote":"127.0.0.1:42366","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-10T14:57:10.413025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.610837705s","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-10T14:57:10.41324Z","caller":"traceutil/trace.go:171","msg":"trace[816513637] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:984; }","duration":"1.611070129s","start":"2026-02-10T14:57:08.802162Z","end":"2026-02-10T14:57:10.413232Z","steps":["trace[816513637] 'agreement among raft nodes before linearized reading' (duration: 1.610517329s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:10.413682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:08.802156Z","time spent":"1.611268432s","remote":"127.0.0.1:42366","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-10T14:57:10.420884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.106175513s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.74\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-10T14:57:10.420923Z","caller":"traceutil/trace.go:171","msg":"trace[1575472585] range","detail":"{range_begin:/registry/masterleases/162.253.55.74; range_end:; response_count:1; response_revision:984; }","duration":"1.106241524s","start":"2026-02-10T14:57:09.314666Z","end":"2026-02-10T14:57:10.420907Z","steps":["trace[1575472585] 'agreement among raft nodes before linearized reading' (duration: 1.095398103s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:10.421065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:09.314648Z","time spent":"1.106287825s","remote":"127.0.0.1:42130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.74\" "}