{"level":"warn","ts":"2026-03-19T08:54:05.510914Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-19T08:54:05.511013Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.33:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.33:2380","--initial-cluster=instance=https://199.204.45.33:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.33:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.33: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-03-19T08:54:05.51107Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-19T08:54:05.511082Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.33:2380"]} {"level":"info","ts":"2026-03-19T08:54:05.5111Z","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-03-19T08:54:05.511711Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"]} {"level":"info","ts":"2026-03-19T08:54:05.51178Z","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":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.33:2380"],"listen-peer-urls":["https://199.204.45.33:2380"],"advertise-client-urls":["https://199.204.45.33:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.33: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-03-19T08:54:05.53345Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"21.491991ms"} {"level":"info","ts":"2026-03-19T08:54:05.590188Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f1e5729930cf7e1f","cluster-id":"14aeb8c3ec66b749"} {"level":"info","ts":"2026-03-19T08:54:05.590308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=()"} {"level":"info","ts":"2026-03-19T08:54:05.590342Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became follower at term 0"} {"level":"info","ts":"2026-03-19T08:54:05.590357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f1e5729930cf7e1f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-19T08:54:05.590386Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became follower at term 1"} {"level":"info","ts":"2026-03-19T08:54:05.590446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=(17430463935081840159)"} {"level":"warn","ts":"2026-03-19T08:54:05.61417Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-19T08:54:05.632427Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-19T08:54:05.634005Z","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-03-19T08:54:05.637637Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f1e5729930cf7e1f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-19T08:54:05.637836Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f1e5729930cf7e1f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-19T08:54:05.638247Z","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-03-19T08:54:05.638458Z","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-03-19T08:54:05.638522Z","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-03-19T08:54:05.642608Z","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-03-19T08:54:05.642736Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.33:2380"} {"level":"info","ts":"2026-03-19T08:54:05.642817Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.33:2380"} {"level":"info","ts":"2026-03-19T08:54:05.64308Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f1e5729930cf7e1f","initial-advertise-peer-urls":["https://199.204.45.33:2380"],"listen-peer-urls":["https://199.204.45.33:2380"],"advertise-client-urls":["https://199.204.45.33:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-19T08:54:05.643188Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-19T08:54:05.659611Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=(17430463935081840159)"} {"level":"info","ts":"2026-03-19T08:54:05.659768Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"14aeb8c3ec66b749","local-member-id":"f1e5729930cf7e1f","added-peer-id":"f1e5729930cf7e1f","added-peer-peer-urls":["https://199.204.45.33:2380"]} {"level":"info","ts":"2026-03-19T08:54:06.191006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f is starting a new election at term 1"} {"level":"info","ts":"2026-03-19T08:54:06.19106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became pre-candidate at term 1"} {"level":"info","ts":"2026-03-19T08:54:06.191095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f received MsgPreVoteResp from f1e5729930cf7e1f at term 1"} {"level":"info","ts":"2026-03-19T08:54:06.191109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became candidate at term 2"} {"level":"info","ts":"2026-03-19T08:54:06.191118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f received MsgVoteResp from f1e5729930cf7e1f at term 2"} {"level":"info","ts":"2026-03-19T08:54:06.191128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became leader at term 2"} {"level":"info","ts":"2026-03-19T08:54:06.191138Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f1e5729930cf7e1f elected leader f1e5729930cf7e1f at term 2"} {"level":"info","ts":"2026-03-19T08:54:06.29762Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-19T08:54:06.299973Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f1e5729930cf7e1f","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.33:2379]}","request-path":"/0/members/f1e5729930cf7e1f/attributes","cluster-id":"14aeb8c3ec66b749","publish-timeout":"7s"} {"level":"info","ts":"2026-03-19T08:54:06.300093Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-19T08:54:06.300837Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-19T08:54:06.301329Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-19T08:54:06.301561Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-19T08:54:06.303671Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"14aeb8c3ec66b749","local-member-id":"f1e5729930cf7e1f","cluster-version":"3.5"} {"level":"info","ts":"2026-03-19T08:54:06.303771Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-19T08:54:06.304149Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-19T08:54:06.304232Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-19T08:54:06.315123Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.33:2379"} {"level":"info","ts":"2026-03-19T08:54:07.848707Z","caller":"traceutil/trace.go:171","msg":"trace[2140316484] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"106.476433ms","start":"2026-03-19T08:54:07.742192Z","end":"2026-03-19T08:54:07.848668Z","steps":["trace[2140316484] 'process raft request' (duration: 65.552476ms)","trace[2140316484] 'compare' (duration: 40.658755ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:54:07.848802Z","caller":"traceutil/trace.go:171","msg":"trace[1779911106] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"105.266625ms","start":"2026-03-19T08:54:07.743498Z","end":"2026-03-19T08:54:07.848765Z","steps":["trace[1779911106] 'process raft request' (duration: 105.059724ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:07.848776Z","caller":"traceutil/trace.go:171","msg":"trace[181633883] transaction","detail":"{read_only:false; response_revision:39; number_of_response:1; }","duration":"103.578126ms","start":"2026-03-19T08:54:07.7451Z","end":"2026-03-19T08:54:07.848678Z","steps":["trace[181633883] 'process raft request' (duration: 103.517406ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:11.391043Z","caller":"traceutil/trace.go:171","msg":"trace[1469494032] transaction","detail":"{read_only:false; number_of_response:0; response_revision:290; }","duration":"241.422419ms","start":"2026-03-19T08:54:11.149591Z","end":"2026-03-19T08:54:11.391013Z","steps":["trace[1469494032] 'process raft request' (duration: 155.378959ms)","trace[1469494032] 'compare' (duration: 85.97485ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:54:11.467862Z","caller":"traceutil/trace.go:171","msg":"trace[2074697863] transaction","detail":"{read_only:false; number_of_response:0; response_revision:290; }","duration":"299.682825ms","start":"2026-03-19T08:54:11.168164Z","end":"2026-03-19T08:54:11.467847Z","steps":["trace[2074697863] 'process raft request' (duration: 299.345433ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:11.467867Z","caller":"traceutil/trace.go:171","msg":"trace[609230556] transaction","detail":"{read_only:false; number_of_response:0; response_revision:292; }","duration":"296.781178ms","start":"2026-03-19T08:54:11.171058Z","end":"2026-03-19T08:54:11.467839Z","steps":["trace[609230556] 'process raft request' (duration: 296.662197ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:11.467889Z","caller":"traceutil/trace.go:171","msg":"trace[380940918] linearizableReadLoop","detail":"{readStateIndex:302; appliedIndex:296; }","duration":"292.821113ms","start":"2026-03-19T08:54:11.175032Z","end":"2026-03-19T08:54:11.467853Z","steps":["trace[380940918] 'read index received' (duration: 130.039439ms)","trace[380940918] 'applied index is now lower than readState.Index' (duration: 162.780754ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:54:11.46794Z","caller":"traceutil/trace.go:171","msg":"trace[907663728] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"299.719924ms","start":"2026-03-19T08:54:11.168204Z","end":"2026-03-19T08:54:11.467924Z","steps":["trace[907663728] 'process raft request' (duration: 299.385302ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:11.467954Z","caller":"traceutil/trace.go:171","msg":"trace[935949322] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"289.710025ms","start":"2026-03-19T08:54:11.178179Z","end":"2026-03-19T08:54:11.467889Z","steps":["trace[935949322] 'process raft request' (duration: 289.605664ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:11.46807Z","caller":"traceutil/trace.go:171","msg":"trace[450870292] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"297.803783ms","start":"2026-03-19T08:54:11.170251Z","end":"2026-03-19T08:54:11.468055Z","steps":["trace[450870292] 'process raft request' (duration: 297.431361ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:11.467853Z","caller":"traceutil/trace.go:171","msg":"trace[1980920992] transaction","detail":"{read_only:false; number_of_response:0; response_revision:291; }","duration":"297.629552ms","start":"2026-03-19T08:54:11.170189Z","end":"2026-03-19T08:54:11.467819Z","steps":["trace[1980920992] 'process raft request' (duration: 297.467961ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:11.468145Z","caller":"traceutil/trace.go:171","msg":"trace[2030056850] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"284.429104ms","start":"2026-03-19T08:54:11.183701Z","end":"2026-03-19T08:54:11.46813Z","steps":["trace[2030056850] 'process raft request' (duration: 284.119902ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:11.46818Z","caller":"traceutil/trace.go:171","msg":"trace[1897871504] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"290.066648ms","start":"2026-03-19T08:54:11.178097Z","end":"2026-03-19T08:54:11.468164Z","steps":["trace[1897871504] 'process raft request' (duration: 289.642044ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:11.468556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.604122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-19T08:54:11.468664Z","caller":"traceutil/trace.go:171","msg":"trace[1383929187] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:0; response_revision:295; }","duration":"356.799963ms","start":"2026-03-19T08:54:11.111844Z","end":"2026-03-19T08:54:11.468644Z","steps":["trace[1383929187] 'agreement among raft nodes before linearized reading' (duration: 356.604062ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:11.468711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:11.111833Z","time spent":"356.864183ms","remote":"127.0.0.1:50938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"warn","ts":"2026-03-19T08:54:11.669049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.433796ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-19T08:54:11.669137Z","caller":"traceutil/trace.go:171","msg":"trace[1818728528] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"194.364231ms","start":"2026-03-19T08:54:11.474759Z","end":"2026-03-19T08:54:11.669124Z","steps":["trace[1818728528] 'process raft request' (duration: 59.418072ms)","trace[1818728528] 'compare' (duration: 134.339745ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:54:11.669939Z","caller":"traceutil/trace.go:171","msg":"trace[673636180] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"193.661897ms","start":"2026-03-19T08:54:11.476251Z","end":"2026-03-19T08:54:11.669913Z","steps":["trace[673636180] 'process raft request' (duration: 193.457835ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:11.669963Z","caller":"traceutil/trace.go:171","msg":"trace[1315102973] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"186.922607ms","start":"2026-03-19T08:54:11.483017Z","end":"2026-03-19T08:54:11.66994Z","steps":["trace[1315102973] 'process raft request' (duration: 186.854687ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:11.670102Z","caller":"traceutil/trace.go:171","msg":"trace[1544995299] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"193.085433ms","start":"2026-03-19T08:54:11.476984Z","end":"2026-03-19T08:54:11.670069Z","steps":["trace[1544995299] 'process raft request' (duration: 192.82785ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:12.070922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.773499ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-19T08:54:12.071025Z","caller":"traceutil/trace.go:171","msg":"trace[1415987678] linearizableReadLoop","detail":"{readStateIndex:314; appliedIndex:313; }","duration":"314.453521ms","start":"2026-03-19T08:54:11.756554Z","end":"2026-03-19T08:54:12.071007Z","steps":["trace[1415987678] 'read index received' (duration: 52.466101ms)","trace[1415987678] 'applied index is now lower than readState.Index' (duration: 261.98606ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T08:54:12.071452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.656331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-19T08:54:12.071565Z","caller":"traceutil/trace.go:171","msg":"trace[253610463] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:304; }","duration":"270.808492ms","start":"2026-03-19T08:54:11.80073Z","end":"2026-03-19T08:54:12.071538Z","steps":["trace[253610463] 'agreement among raft nodes before linearized reading' (duration: 270.43182ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:12.071809Z","caller":"traceutil/trace.go:171","msg":"trace[1605111470] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"315.265455ms","start":"2026-03-19T08:54:11.756525Z","end":"2026-03-19T08:54:12.07179Z","steps":["trace[1605111470] 'process raft request' (duration: 52.549121ms)","trace[1605111470] 'compare' (duration: 261.291826ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T08:54:12.071922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:11.756507Z","time spent":"315.359736ms","remote":"127.0.0.1:51222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2651,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-19T08:54:12.072058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.498777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-03-19T08:54:12.072322Z","caller":"traceutil/trace.go:171","msg":"trace[862176231] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:304; }","duration":"315.781708ms","start":"2026-03-19T08:54:11.756528Z","end":"2026-03-19T08:54:12.07231Z","steps":["trace[862176231] 'agreement among raft nodes before linearized reading' (duration: 315.483287ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:12.072355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:11.756518Z","time spent":"315.829569ms","remote":"127.0.0.1:50852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-03-19T08:54:12.072508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.505406ms","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-03-19T08:54:12.072544Z","caller":"traceutil/trace.go:171","msg":"trace[1416006996] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:304; }","duration":"207.569088ms","start":"2026-03-19T08:54:11.864967Z","end":"2026-03-19T08:54:12.072536Z","steps":["trace[1416006996] 'agreement among raft nodes before linearized reading' (duration: 207.509207ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:12.072559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.682982ms","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-03-19T08:54:12.072868Z","caller":"traceutil/trace.go:171","msg":"trace[271932825] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:304; }","duration":"207.038704ms","start":"2026-03-19T08:54:11.865804Z","end":"2026-03-19T08:54:12.072843Z","steps":["trace[271932825] 'agreement among raft nodes before linearized reading' (duration: 206.570962ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:12.36822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.619605ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-03-19T08:54:12.368672Z","caller":"traceutil/trace.go:171","msg":"trace[1902888859] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"291.477428ms","start":"2026-03-19T08:54:12.077166Z","end":"2026-03-19T08:54:12.368643Z","steps":["trace[1902888859] 'process raft request' (duration: 291.141317ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:12.36872Z","caller":"traceutil/trace.go:171","msg":"trace[1331982219] transaction","detail":"{read_only:false; number_of_response:0; response_revision:305; }","duration":"291.647169ms","start":"2026-03-19T08:54:12.077025Z","end":"2026-03-19T08:54:12.368672Z","steps":["trace[1331982219] 'process raft request' (duration: 166.515001ms)","trace[1331982219] 'compare' (duration: 124.571204ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:54:12.368812Z","caller":"traceutil/trace.go:171","msg":"trace[1646094385] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"291.426778ms","start":"2026-03-19T08:54:12.077347Z","end":"2026-03-19T08:54:12.368774Z","steps":["trace[1646094385] 'process raft request' (duration: 291.032966ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:12.368992Z","caller":"traceutil/trace.go:171","msg":"trace[1658054067] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"185.161241ms","start":"2026-03-19T08:54:12.183796Z","end":"2026-03-19T08:54:12.368957Z","steps":["trace[1658054067] 'process raft request' (duration: 185.122881ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:12.368996Z","caller":"traceutil/trace.go:171","msg":"trace[834606026] transaction","detail":"{read_only:false; number_of_response:0; response_revision:307; }","duration":"290.749084ms","start":"2026-03-19T08:54:12.078233Z","end":"2026-03-19T08:54:12.368982Z","steps":["trace[834606026] 'process raft request' (duration: 290.563523ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:12.36906Z","caller":"traceutil/trace.go:171","msg":"trace[1050032737] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"289.947699ms","start":"2026-03-19T08:54:12.079099Z","end":"2026-03-19T08:54:12.369047Z","steps":["trace[1050032737] 'process raft request' (duration: 289.750957ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:12.369146Z","caller":"traceutil/trace.go:171","msg":"trace[1980454222] transaction","detail":"{read_only:false; number_of_response:0; response_revision:307; }","duration":"291.302677ms","start":"2026-03-19T08:54:12.077834Z","end":"2026-03-19T08:54:12.369137Z","steps":["trace[1980454222] 'process raft request' (duration: 290.579653ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:12.369154Z","caller":"traceutil/trace.go:171","msg":"trace[1820673444] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"290.553253ms","start":"2026-03-19T08:54:12.078593Z","end":"2026-03-19T08:54:12.369146Z","steps":["trace[1820673444] 'process raft request' (duration: 290.223221ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:12.369244Z","caller":"traceutil/trace.go:171","msg":"trace[1805002931] transaction","detail":"{read_only:false; number_of_response:0; response_revision:307; }","duration":"291.252597ms","start":"2026-03-19T08:54:12.077984Z","end":"2026-03-19T08:54:12.369237Z","steps":["trace[1805002931] 'process raft request' (duration: 290.739434ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:12.369312Z","caller":"traceutil/trace.go:171","msg":"trace[1730129498] transaction","detail":"{read_only:false; number_of_response:0; response_revision:307; }","duration":"291.300277ms","start":"2026-03-19T08:54:12.078002Z","end":"2026-03-19T08:54:12.369302Z","steps":["trace[1730129498] 'process raft request' (duration: 290.746644ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:12.36932Z","caller":"traceutil/trace.go:171","msg":"trace[653002536] linearizableReadLoop","detail":"{readStateIndex:324; appliedIndex:315; }","duration":"201.585078ms","start":"2026-03-19T08:54:12.167725Z","end":"2026-03-19T08:54:12.36931Z","steps":["trace[653002536] 'read index received' (duration: 75.776396ms)","trace[653002536] 'applied index is now lower than readState.Index' (duration: 125.807912ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T08:54:12.369393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.651608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-03-19T08:54:12.369432Z","caller":"traceutil/trace.go:171","msg":"trace[1392517626] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:310; }","duration":"201.741579ms","start":"2026-03-19T08:54:12.16768Z","end":"2026-03-19T08:54:12.369421Z","steps":["trace[1392517626] 'agreement among raft nodes before linearized reading' (duration: 201.663268ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:12.571419Z","caller":"traceutil/trace.go:171","msg":"trace[965284917] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"126.858797ms","start":"2026-03-19T08:54:12.444513Z","end":"2026-03-19T08:54:12.571371Z","steps":["trace[965284917] 'process raft request' (duration: 91.069387ms)","trace[965284917] 'compare' (duration: 35.622409ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:54:12.572226Z","caller":"traceutil/trace.go:171","msg":"trace[814231725] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"126.537797ms","start":"2026-03-19T08:54:12.445673Z","end":"2026-03-19T08:54:12.572211Z","steps":["trace[814231725] 'process raft request' (duration: 126.449006ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:12.730746Z","caller":"traceutil/trace.go:171","msg":"trace[30651073] linearizableReadLoop","detail":"{readStateIndex:336; appliedIndex:335; }","duration":"102.061521ms","start":"2026-03-19T08:54:12.628655Z","end":"2026-03-19T08:54:12.730716Z","steps":["trace[30651073] 'read index received' (duration: 53.766666ms)","trace[30651073] 'applied index is now lower than readState.Index' (duration: 48.293705ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T08:54:12.730891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.317132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-03-19T08:54:12.730891Z","caller":"traceutil/trace.go:171","msg":"trace[2113905719] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"130.219187ms","start":"2026-03-19T08:54:12.600631Z","end":"2026-03-19T08:54:12.73085Z","steps":["trace[2113905719] 'process raft request' (duration: 81.877642ms)","trace[2113905719] 'compare' (duration: 47.989443ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:54:12.730934Z","caller":"traceutil/trace.go:171","msg":"trace[1581466083] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:321; }","duration":"102.403813ms","start":"2026-03-19T08:54:12.628517Z","end":"2026-03-19T08:54:12.730921Z","steps":["trace[1581466083] 'agreement among raft nodes before linearized reading' (duration: 102.301982ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:18.343887Z","caller":"traceutil/trace.go:171","msg":"trace[916729796] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"493.882132ms","start":"2026-03-19T08:54:17.849981Z","end":"2026-03-19T08:54:18.343863Z","steps":["trace[916729796] 'process raft request' (duration: 493.706851ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:18.344071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:17.849953Z","time spent":"494.016242ms","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-19T08:54:19.251842Z","caller":"traceutil/trace.go:171","msg":"trace[401128114] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"152.296181ms","start":"2026-03-19T08:54:19.09952Z","end":"2026-03-19T08:54:19.251816Z","steps":["trace[401128114] 'process raft request' (duration: 152.13993ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:21.17447Z","caller":"traceutil/trace.go:171","msg":"trace[50305632] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"103.274483ms","start":"2026-03-19T08:54:21.071173Z","end":"2026-03-19T08:54:21.174448Z","steps":["trace[50305632] 'process raft request' (duration: 103.141417ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:22.737338Z","caller":"traceutil/trace.go:171","msg":"trace[156679216] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"115.13985ms","start":"2026-03-19T08:54:22.622174Z","end":"2026-03-19T08:54:22.737314Z","steps":["trace[156679216] 'process raft request' (duration: 60.64321ms)","trace[156679216] 'compare' (duration: 54.365134ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:54:22.7375Z","caller":"traceutil/trace.go:171","msg":"trace[1824887599] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"114.91923ms","start":"2026-03-19T08:54:22.622551Z","end":"2026-03-19T08:54:22.737471Z","steps":["trace[1824887599] 'process raft request' (duration: 114.71996ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:25.10522Z","caller":"traceutil/trace.go:171","msg":"trace[1653099795] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"479.803848ms","start":"2026-03-19T08:54:24.62539Z","end":"2026-03-19T08:54:25.105194Z","steps":["trace[1653099795] 'process raft request' (duration: 479.64944ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:25.105436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:24.625371Z","time spent":"479.920353ms","remote":"127.0.0.1:51016","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-03-19T08:54:25.322226Z","caller":"traceutil/trace.go:171","msg":"trace[1244488512] linearizableReadLoop","detail":"{readStateIndex:437; appliedIndex:435; }","duration":"654.947943ms","start":"2026-03-19T08:54:24.667254Z","end":"2026-03-19T08:54:25.322202Z","steps":["trace[1244488512] 'read index received' (duration: 437.796211ms)","trace[1244488512] 'applied index is now lower than readState.Index' (duration: 217.150562ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T08:54:25.322417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.649511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-03-19T08:54:25.322397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.120531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-03-19T08:54:25.322436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.675608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-19T08:54:25.322461Z","caller":"traceutil/trace.go:171","msg":"trace[1356865915] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:419; }","duration":"579.743986ms","start":"2026-03-19T08:54:24.742697Z","end":"2026-03-19T08:54:25.322441Z","steps":["trace[1356865915] 'agreement among raft nodes before linearized reading' (duration: 579.62996ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:25.322496Z","caller":"traceutil/trace.go:171","msg":"trace[163351054] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:419; }","duration":"563.776763ms","start":"2026-03-19T08:54:24.758703Z","end":"2026-03-19T08:54:25.32248Z","steps":["trace[163351054] 'agreement among raft nodes before linearized reading' (duration: 563.686579ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:25.322498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:24.742496Z","time spent":"579.994417ms","remote":"127.0.0.1:51016","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-03-19T08:54:25.322468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.334342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4322"} {"level":"info","ts":"2026-03-19T08:54:25.3225Z","caller":"traceutil/trace.go:171","msg":"trace[2059100080] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:419; }","duration":"655.272158ms","start":"2026-03-19T08:54:24.6672Z","end":"2026-03-19T08:54:25.322472Z","steps":["trace[2059100080] 'agreement among raft nodes before linearized reading' (duration: 655.078029ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:25.322528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:24.758685Z","time spent":"563.836846ms","remote":"127.0.0.1:50744","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-03-19T08:54:25.322512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.728505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-03-19T08:54:25.322559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:24.667173Z","time spent":"655.376382ms","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-03-19T08:54:25.322556Z","caller":"traceutil/trace.go:171","msg":"trace[3420660] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:419; }","duration":"448.471129ms","start":"2026-03-19T08:54:24.874065Z","end":"2026-03-19T08:54:25.322536Z","steps":["trace[3420660] 'agreement among raft nodes before linearized reading' (duration: 448.28174ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:25.32259Z","caller":"traceutil/trace.go:171","msg":"trace[1699479044] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:419; }","duration":"579.83515ms","start":"2026-03-19T08:54:24.742725Z","end":"2026-03-19T08:54:25.32256Z","steps":["trace[1699479044] 'agreement among raft nodes before linearized reading' (duration: 579.691943ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:25.32262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:24.874048Z","time spent":"448.560262ms","remote":"127.0.0.1:50918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4345,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-03-19T08:54:25.32263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:24.742704Z","time spent":"579.917114ms","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-03-19T08:54:27.389027Z","caller":"traceutil/trace.go:171","msg":"trace[473701130] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"276.087027ms","start":"2026-03-19T08:54:27.112917Z","end":"2026-03-19T08:54:27.389004Z","steps":["trace[473701130] 'process raft request' (duration: 275.845726ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:27.55945Z","caller":"traceutil/trace.go:171","msg":"trace[2132079662] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"155.938259ms","start":"2026-03-19T08:54:27.403489Z","end":"2026-03-19T08:54:27.559427Z","steps":["trace[2132079662] 'process raft request' (duration: 155.896287ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:27.5599Z","caller":"traceutil/trace.go:171","msg":"trace[796016844] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"162.052389ms","start":"2026-03-19T08:54:27.397761Z","end":"2026-03-19T08:54:27.559813Z","steps":["trace[796016844] 'process raft request' (duration: 161.551937ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:27.559874Z","caller":"traceutil/trace.go:171","msg":"trace[104150500] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"166.194052ms","start":"2026-03-19T08:54:27.393449Z","end":"2026-03-19T08:54:27.559643Z","steps":["trace[104150500] 'process raft request' (duration: 86.799915ms)","trace[104150500] 'compare' (duration: 78.643723ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:54:29.637086Z","caller":"traceutil/trace.go:171","msg":"trace[1087135221] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"166.260427ms","start":"2026-03-19T08:54:29.470775Z","end":"2026-03-19T08:54:29.637036Z","steps":["trace[1087135221] 'process raft request' (duration: 166.144522ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:29.637084Z","caller":"traceutil/trace.go:171","msg":"trace[833155739] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"168.944272ms","start":"2026-03-19T08:54:29.468059Z","end":"2026-03-19T08:54:29.637004Z","steps":["trace[833155739] 'process raft request' (duration: 93.321912ms)","trace[833155739] 'compare' (duration: 75.331298ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T08:54:32.164727Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088155219154311625,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-19T08:54:32.179119Z","caller":"traceutil/trace.go:171","msg":"trace[2084730007] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"532.815309ms","start":"2026-03-19T08:54:31.64627Z","end":"2026-03-19T08:54:32.179085Z","steps":["trace[2084730007] 'process raft request' (duration: 532.628102ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:32.179442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:31.646246Z","time spent":"532.968596ms","remote":"127.0.0.1:51016","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-03-19T08:54:32.226637Z","caller":"traceutil/trace.go:171","msg":"trace[2046356326] linearizableReadLoop","detail":"{readStateIndex:456; appliedIndex:454; }","duration":"562.728054ms","start":"2026-03-19T08:54:31.66389Z","end":"2026-03-19T08:54:32.226618Z","steps":["trace[2046356326] 'read index received' (duration: 514.98686ms)","trace[2046356326] 'applied index is now lower than readState.Index' (duration: 47.740524ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:54:32.226705Z","caller":"traceutil/trace.go:171","msg":"trace[825479271] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"366.31427ms","start":"2026-03-19T08:54:31.860365Z","end":"2026-03-19T08:54:32.226679Z","steps":["trace[825479271] 'process raft request' (duration: 366.154473ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:32.22678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.70191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-03-19T08:54:32.226798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:31.860332Z","time spent":"366.419815ms","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-19T08:54:32.226794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.905201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-03-19T08:54:32.22683Z","caller":"traceutil/trace.go:171","msg":"trace[732653294] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:437; }","duration":"560.795673ms","start":"2026-03-19T08:54:31.666023Z","end":"2026-03-19T08:54:32.226818Z","steps":["trace[732653294] 'agreement among raft nodes before linearized reading' (duration: 560.692399ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:32.226853Z","caller":"traceutil/trace.go:171","msg":"trace[282027976] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:437; }","duration":"563.033966ms","start":"2026-03-19T08:54:31.663803Z","end":"2026-03-19T08:54:32.226837Z","steps":["trace[282027976] 'agreement among raft nodes before linearized reading' (duration: 562.917571ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:32.226873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:31.666006Z","time spent":"560.857705ms","remote":"127.0.0.1:51016","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-03-19T08:54:32.2269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:31.663777Z","time spent":"563.114399ms","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-19T08:54:32.226932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.425427ms","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-03-19T08:54:32.227037Z","caller":"traceutil/trace.go:171","msg":"trace[1593525182] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:437; }","duration":"560.565643ms","start":"2026-03-19T08:54:31.666448Z","end":"2026-03-19T08:54:32.227014Z","steps":["trace[1593525182] 'agreement among raft nodes before linearized reading' (duration: 560.382085ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:32.227086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:31.666434Z","time spent":"560.642785ms","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-19T08:54:36.548426Z","caller":"traceutil/trace.go:171","msg":"trace[1809291685] linearizableReadLoop","detail":"{readStateIndex:466; appliedIndex:465; }","duration":"249.33147ms","start":"2026-03-19T08:54:36.299068Z","end":"2026-03-19T08:54:36.548399Z","steps":["trace[1809291685] 'read index received' (duration: 249.119101ms)","trace[1809291685] 'applied index is now lower than readState.Index' (duration: 211.449µs)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:54:36.548656Z","caller":"traceutil/trace.go:171","msg":"trace[140634736] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"281.950832ms","start":"2026-03-19T08:54:36.266662Z","end":"2026-03-19T08:54:36.548612Z","steps":["trace[140634736] 'process raft request' (duration: 281.534396ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:36.548782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.701084ms","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-03-19T08:54:36.548848Z","caller":"traceutil/trace.go:171","msg":"trace[2127613568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:446; }","duration":"249.792348ms","start":"2026-03-19T08:54:36.299039Z","end":"2026-03-19T08:54:36.548832Z","steps":["trace[2127613568] 'agreement among raft nodes before linearized reading' (duration: 249.501146ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:36.548714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.484976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-03-19T08:54:36.549017Z","caller":"traceutil/trace.go:171","msg":"trace[85380958] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:446; }","duration":"248.858241ms","start":"2026-03-19T08:54:36.30014Z","end":"2026-03-19T08:54:36.548998Z","steps":["trace[85380958] 'agreement among raft nodes before linearized reading' (duration: 248.448614ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:38.080958Z","caller":"traceutil/trace.go:171","msg":"trace[1421924807] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"106.313058ms","start":"2026-03-19T08:54:37.974619Z","end":"2026-03-19T08:54:38.080932Z","steps":["trace[1421924807] 'process raft request' (duration: 106.125091ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:39.928234Z","caller":"traceutil/trace.go:171","msg":"trace[1058701791] linearizableReadLoop","detail":"{readStateIndex:475; appliedIndex:474; }","duration":"236.961784ms","start":"2026-03-19T08:54:39.691247Z","end":"2026-03-19T08:54:39.928209Z","steps":["trace[1058701791] 'read index received' (duration: 236.796018ms)","trace[1058701791] 'applied index is now lower than readState.Index' (duration: 164.636µs)"],"step_count":2} {"level":"warn","ts":"2026-03-19T08:54:39.928256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:39.388847Z","time spent":"539.402262ms","remote":"127.0.0.1:50774","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-03-19T08:54:39.928386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.12549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4056"} {"level":"info","ts":"2026-03-19T08:54:39.928477Z","caller":"traceutil/trace.go:171","msg":"trace[1681501878] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:454; }","duration":"237.276356ms","start":"2026-03-19T08:54:39.69119Z","end":"2026-03-19T08:54:39.928466Z","steps":["trace[1681501878] 'agreement among raft nodes before linearized reading' (duration: 237.11736ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:40.231862Z","caller":"traceutil/trace.go:171","msg":"trace[619475327] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"161.156952ms","start":"2026-03-19T08:54:40.070677Z","end":"2026-03-19T08:54:40.231833Z","steps":["trace[619475327] 'process raft request' (duration: 98.624258ms)","trace[619475327] 'compare' (duration: 62.378308ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:54:40.272526Z","caller":"traceutil/trace.go:171","msg":"trace[467018499] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"172.314434ms","start":"2026-03-19T08:54:40.100176Z","end":"2026-03-19T08:54:40.27249Z","steps":["trace[467018499] 'process raft request' (duration: 172.080195ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:40.852137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.979888ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-19T08:54:40.852419Z","caller":"traceutil/trace.go:171","msg":"trace[174764756] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"615.893153ms","start":"2026-03-19T08:54:40.236494Z","end":"2026-03-19T08:54:40.852387Z","steps":["trace[174764756] 'process raft request' (duration: 109.596473ms)","trace[174764756] 'compare' (duration: 505.817691ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T08:54:40.852572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:40.236463Z","time spent":"616.045028ms","remote":"127.0.0.1:50810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-19T08:54:40.852602Z","caller":"traceutil/trace.go:171","msg":"trace[1414148131] linearizableReadLoop","detail":"{readStateIndex:486; appliedIndex:482; }","duration":"576.459002ms","start":"2026-03-19T08:54:40.276121Z","end":"2026-03-19T08:54:40.85258Z","steps":["trace[1414148131] 'read index received' (duration: 69.902702ms)","trace[1414148131] 'applied index is now lower than readState.Index' (duration: 506.55492ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:54:40.852771Z","caller":"traceutil/trace.go:171","msg":"trace[985604405] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"614.619615ms","start":"2026-03-19T08:54:40.238105Z","end":"2026-03-19T08:54:40.852724Z","steps":["trace[985604405] 'process raft request' (duration: 614.136037ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:40.852895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:40.238076Z","time spent":"614.73628ms","remote":"127.0.0.1:50810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-19T08:54:40.853124Z","caller":"traceutil/trace.go:171","msg":"trace[1407411094] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"614.593923ms","start":"2026-03-19T08:54:40.238518Z","end":"2026-03-19T08:54:40.853111Z","steps":["trace[1407411094] 'process raft request' (duration: 613.788203ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:40.853205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:40.238507Z","time spent":"614.655205ms","remote":"127.0.0.1:51226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3795,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-19T08:54:40.853403Z","caller":"traceutil/trace.go:171","msg":"trace[2104407188] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"611.379652ms","start":"2026-03-19T08:54:40.241965Z","end":"2026-03-19T08:54:40.853344Z","steps":["trace[2104407188] 'process raft request' (duration: 610.461567ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:40.853636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:40.241951Z","time spent":"611.567269ms","remote":"127.0.0.1:50918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4037,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-19T08:54:40.853765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.633006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-n688w\" ","response":"range_response_count:1 size:4016"} {"level":"warn","ts":"2026-03-19T08:54:40.854338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.839942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-03-19T08:54:40.854378Z","caller":"traceutil/trace.go:171","msg":"trace[2070318882] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:467; }","duration":"573.903656ms","start":"2026-03-19T08:54:40.280465Z","end":"2026-03-19T08:54:40.854369Z","steps":["trace[2070318882] 'agreement among raft nodes before linearized reading' (duration: 573.821133ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:40.8544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:40.280455Z","time spent":"573.940487ms","remote":"127.0.0.1:51210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4218,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"info","ts":"2026-03-19T08:54:40.854647Z","caller":"traceutil/trace.go:171","msg":"trace[729655486] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"578.00153ms","start":"2026-03-19T08:54:40.276631Z","end":"2026-03-19T08:54:40.854633Z","steps":["trace[729655486] 'process raft request' (duration: 577.585194ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:40.854715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:40.276618Z","time spent":"578.056561ms","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-19T08:54:40.854814Z","caller":"traceutil/trace.go:171","msg":"trace[624608619] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"577.862246ms","start":"2026-03-19T08:54:40.276939Z","end":"2026-03-19T08:54:40.854801Z","steps":["trace[624608619] 'process raft request' (duration: 577.324545ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:40.85487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:40.276917Z","time spent":"577.932138ms","remote":"127.0.0.1:50810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":689,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-19T08:54:40.85501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.677587ms","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-03-19T08:54:40.855039Z","caller":"traceutil/trace.go:171","msg":"trace[482218053] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:467; }","duration":"136.725659ms","start":"2026-03-19T08:54:40.718306Z","end":"2026-03-19T08:54:40.855032Z","steps":["trace[482218053] 'agreement among raft nodes before linearized reading' (duration: 136.665667ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:40.855134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.847153ms","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-03-19T08:54:40.855158Z","caller":"traceutil/trace.go:171","msg":"trace[448550567] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:467; }","duration":"136.909945ms","start":"2026-03-19T08:54:40.718242Z","end":"2026-03-19T08:54:40.855152Z","steps":["trace[448550567] 'agreement among raft nodes before linearized reading' (duration: 136.870504ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:40.855224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.720931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-03-19T08:54:40.855303Z","caller":"traceutil/trace.go:171","msg":"trace[1624619612] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:467; }","duration":"285.842626ms","start":"2026-03-19T08:54:40.569423Z","end":"2026-03-19T08:54:40.855266Z","steps":["trace[1624619612] 'agreement among raft nodes before linearized reading' (duration: 285.6934ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:40.85572Z","caller":"traceutil/trace.go:171","msg":"trace[336198104] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-n688w; range_end:; response_count:1; response_revision:465; }","duration":"577.73583ms","start":"2026-03-19T08:54:40.276062Z","end":"2026-03-19T08:54:40.853798Z","steps":["trace[336198104] 'agreement among raft nodes before linearized reading' (duration: 577.428968ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:40.855785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:40.276046Z","time spent":"579.721495ms","remote":"127.0.0.1:50918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":4039,"request content":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-n688w\" "} {"level":"warn","ts":"2026-03-19T08:54:41.168783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.156222ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:4039"} {"level":"info","ts":"2026-03-19T08:54:41.168936Z","caller":"traceutil/trace.go:171","msg":"trace[472171837] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"249.73656ms","start":"2026-03-19T08:54:40.919186Z","end":"2026-03-19T08:54:41.168923Z","steps":["trace[472171837] 'process raft request' (duration: 249.667857ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:41.169012Z","caller":"traceutil/trace.go:171","msg":"trace[484818668] transaction","detail":"{read_only:false; number_of_response:1; response_revision:472; }","duration":"252.629009ms","start":"2026-03-19T08:54:40.916332Z","end":"2026-03-19T08:54:41.168961Z","steps":["trace[484818668] 'process raft request' (duration: 60.221567ms)","trace[484818668] 'compare' (duration: 192.0783ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:54:41.185602Z","caller":"traceutil/trace.go:171","msg":"trace[1429274757] linearizableReadLoop","detail":"{readStateIndex:497; appliedIndex:496; }","duration":"136.049914ms","start":"2026-03-19T08:54:41.049533Z","end":"2026-03-19T08:54:41.185583Z","steps":["trace[1429274757] 'read index received' (duration: 136.029223ms)","trace[1429274757] 'applied index is now lower than readState.Index' (duration: 19.891µs)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:54:41.185678Z","caller":"traceutil/trace.go:171","msg":"trace[1184715027] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"233.402595ms","start":"2026-03-19T08:54:40.952233Z","end":"2026-03-19T08:54:41.185635Z","steps":["trace[1184715027] 'process raft request' (duration: 233.24643ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:41.185729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.393536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-19T08:54:41.185771Z","caller":"traceutil/trace.go:171","msg":"trace[1953465661] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:474; }","duration":"136.471189ms","start":"2026-03-19T08:54:41.049281Z","end":"2026-03-19T08:54:41.185752Z","steps":["trace[1953465661] 'agreement among raft nodes before linearized reading' (duration: 136.405006ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:42.14628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:41.543854Z","time spent":"602.41665ms","remote":"127.0.0.1:60932","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-03-19T08:54:42.146568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.646272ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-19T08:54:42.146871Z","caller":"traceutil/trace.go:171","msg":"trace[1077837965] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"953.019688ms","start":"2026-03-19T08:54:41.19383Z","end":"2026-03-19T08:54:42.146849Z","steps":["trace[1077837965] 'process raft request' (duration: 644.002592ms)","trace[1077837965] 'compare' (duration: 308.517037ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T08:54:42.146952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:41.193803Z","time spent":"953.115101ms","remote":"127.0.0.1:51210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-19T08:54:42.147073Z","caller":"traceutil/trace.go:171","msg":"trace[391481743] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"948.534021ms","start":"2026-03-19T08:54:41.198518Z","end":"2026-03-19T08:54:42.147052Z","steps":["trace[391481743] 'process raft request' (duration: 948.272952ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:42.147163Z","caller":"traceutil/trace.go:171","msg":"trace[1113041090] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"950.503294ms","start":"2026-03-19T08:54:41.196649Z","end":"2026-03-19T08:54:42.147152Z","steps":["trace[1113041090] 'process raft request' (duration: 950.029676ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:42.147194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:41.198512Z","time spent":"948.607734ms","remote":"127.0.0.1:51226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3804,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-19T08:54:42.147223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:41.19664Z","time spent":"950.557375ms","remote":"127.0.0.1:50810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-19T08:54:42.232778Z","caller":"traceutil/trace.go:171","msg":"trace[2074483236] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"992.87288ms","start":"2026-03-19T08:54:41.239866Z","end":"2026-03-19T08:54:42.232739Z","steps":["trace[2074483236] 'process raft request' (duration: 992.441495ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:42.232805Z","caller":"traceutil/trace.go:171","msg":"trace[1724057175] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"989.691461ms","start":"2026-03-19T08:54:41.243088Z","end":"2026-03-19T08:54:42.232779Z","steps":["trace[1724057175] 'process raft request' (duration: 989.626809ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:42.232962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:41.239842Z","time spent":"993.015946ms","remote":"127.0.0.1:50810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-19T08:54:42.233184Z","caller":"traceutil/trace.go:171","msg":"trace[2015079617] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"992.297499ms","start":"2026-03-19T08:54:41.240876Z","end":"2026-03-19T08:54:42.233174Z","steps":["trace[2015079617] 'process raft request' (duration: 991.774869ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:42.232956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:41.243069Z","time spent":"989.798995ms","remote":"127.0.0.1:50918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4037,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-19T08:54:42.233254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:41.240859Z","time spent":"992.363082ms","remote":"127.0.0.1:51226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3840,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-19T08:54:42.951691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.909176ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-19T08:54:42.95196Z","caller":"traceutil/trace.go:171","msg":"trace[1745399566] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"794.929779ms","start":"2026-03-19T08:54:42.157012Z","end":"2026-03-19T08:54:42.951942Z","steps":["trace[1745399566] 'process raft request' (duration: 794.876477ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:42.951961Z","caller":"traceutil/trace.go:171","msg":"trace[1747356113] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"798.497002ms","start":"2026-03-19T08:54:42.153428Z","end":"2026-03-19T08:54:42.951925Z","steps":["trace[1747356113] 'process raft request' (duration: 361.284844ms)","trace[1747356113] 'compare' (duration: 436.791852ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T08:54:42.952431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:42.156988Z","time spent":"795.012962ms","remote":"127.0.0.1:51210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-19T08:54:42.954416Z","caller":"traceutil/trace.go:171","msg":"trace[1311152810] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"798.537483ms","start":"2026-03-19T08:54:42.155856Z","end":"2026-03-19T08:54:42.954394Z","steps":["trace[1311152810] 'process raft request' (duration: 795.954117ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:42.954637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:42.155848Z","time spent":"798.598115ms","remote":"127.0.0.1:51226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3804,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-19T08:54:42.957786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:42.153396Z","time spent":"798.658317ms","remote":"127.0.0.1:50810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-19T08:54:43.03798Z","caller":"traceutil/trace.go:171","msg":"trace[856505003] linearizableReadLoop","detail":"{readStateIndex:511; appliedIndex:509; }","duration":"179.084471ms","start":"2026-03-19T08:54:42.858863Z","end":"2026-03-19T08:54:43.037947Z","steps":["trace[856505003] 'read index received' (duration: 178.696747ms)","trace[856505003] 'applied index is now lower than readState.Index' (duration: 386.074µs)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:54:43.038121Z","caller":"traceutil/trace.go:171","msg":"trace[1049240939] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"763.002576ms","start":"2026-03-19T08:54:42.275103Z","end":"2026-03-19T08:54:43.038106Z","steps":["trace[1049240939] 'process raft request' (duration: 762.762528ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:43.038126Z","caller":"traceutil/trace.go:171","msg":"trace[1349143797] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"796.62334ms","start":"2026-03-19T08:54:42.24146Z","end":"2026-03-19T08:54:43.038084Z","steps":["trace[1349143797] 'process raft request' (duration: 796.110651ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:43.038239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:42.275069Z","time spent":"763.08113ms","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-19T08:54:43.038254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.377642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-03-19T08:54:43.038326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:42.241433Z","time spent":"796.785825ms","remote":"127.0.0.1:51226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3840,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-19T08:54:43.038348Z","caller":"traceutil/trace.go:171","msg":"trace[531877744] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:488; }","duration":"179.520326ms","start":"2026-03-19T08:54:42.858809Z","end":"2026-03-19T08:54:43.038329Z","steps":["trace[531877744] 'agreement among raft nodes before linearized reading' (duration: 179.317959ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:43.360284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.021392ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-19T08:54:43.360439Z","caller":"traceutil/trace.go:171","msg":"trace[38872998] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"394.193829ms","start":"2026-03-19T08:54:42.966208Z","end":"2026-03-19T08:54:43.360402Z","steps":["trace[38872998] 'process raft request' (duration: 273.96748ms)","trace[38872998] 'compare' (duration: 119.907317ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:54:43.360506Z","caller":"traceutil/trace.go:171","msg":"trace[2134483827] linearizableReadLoop","detail":"{readStateIndex:512; appliedIndex:511; }","duration":"322.411941ms","start":"2026-03-19T08:54:43.038067Z","end":"2026-03-19T08:54:43.360479Z","steps":["trace[2134483827] 'read index received' (duration: 202.205232ms)","trace[2134483827] 'applied index is now lower than readState.Index' (duration: 120.204679ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T08:54:43.360622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:42.966191Z","time spent":"394.341894ms","remote":"127.0.0.1:51210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-19T08:54:43.360619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.326241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-03-19T08:54:43.360612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.713312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-03-19T08:54:43.360661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.939561ms","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-03-19T08:54:43.360689Z","caller":"traceutil/trace.go:171","msg":"trace[1112575015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:490; }","duration":"413.003633ms","start":"2026-03-19T08:54:42.947677Z","end":"2026-03-19T08:54:43.360681Z","steps":["trace[1112575015] 'agreement among raft nodes before linearized reading' (duration: 412.908139ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:43.36047Z","caller":"traceutil/trace.go:171","msg":"trace[1040961424] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"317.620176ms","start":"2026-03-19T08:54:43.042833Z","end":"2026-03-19T08:54:43.360453Z","steps":["trace[1040961424] 'process raft request' (duration: 317.559443ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:43.360712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:42.94766Z","time spent":"413.046464ms","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-19T08:54:43.360721Z","caller":"traceutil/trace.go:171","msg":"trace[1560314583] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:490; }","duration":"412.877588ms","start":"2026-03-19T08:54:42.947801Z","end":"2026-03-19T08:54:43.360679Z","steps":["trace[1560314583] 'agreement among raft nodes before linearized reading' (duration: 412.707872ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:43.360758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.121712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-19T08:54:43.360773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:42.947765Z","time spent":"412.995022ms","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-03-19T08:54:43.360685Z","caller":"traceutil/trace.go:171","msg":"trace[1531756046] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:490; }","duration":"411.412164ms","start":"2026-03-19T08:54:42.949255Z","end":"2026-03-19T08:54:43.360667Z","steps":["trace[1531756046] 'agreement among raft nodes before linearized reading' (duration: 411.226958ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:54:43.360823Z","caller":"traceutil/trace.go:171","msg":"trace[1585526415] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:490; }","duration":"313.219405ms","start":"2026-03-19T08:54:43.047582Z","end":"2026-03-19T08:54:43.360802Z","steps":["trace[1585526415] 'agreement among raft nodes before linearized reading' (duration: 313.117852ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:43.360827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:42.949242Z","time spent":"411.57408ms","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-19T08:54:43.360827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:43.042808Z","time spent":"317.927597ms","remote":"127.0.0.1:51016","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-03-19T08:54:43.360867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:54:43.047564Z","time spent":"313.292938ms","remote":"127.0.0.1:50744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-19T08:54:43.702621Z","caller":"traceutil/trace.go:171","msg":"trace[1196630356] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"250.36034ms","start":"2026-03-19T08:54:43.452242Z","end":"2026-03-19T08:54:43.702603Z","steps":["trace[1196630356] 'process raft request' (duration: 250.244986ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:53.603843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.597297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-03-19T08:54:53.603928Z","caller":"traceutil/trace.go:171","msg":"trace[102437277] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:547; }","duration":"118.715661ms","start":"2026-03-19T08:54:53.485195Z","end":"2026-03-19T08:54:53.603911Z","steps":["trace[102437277] 'range keys from in-memory index tree' (duration: 118.471684ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:54:53.60378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.144198ms","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-03-19T08:54:53.60438Z","caller":"traceutil/trace.go:171","msg":"trace[454368227] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:547; }","duration":"124.78873ms","start":"2026-03-19T08:54:53.479568Z","end":"2026-03-19T08:54:53.604356Z","steps":["trace[454368227] 'range keys from in-memory index tree' (duration: 124.055466ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:03.117347Z","caller":"traceutil/trace.go:171","msg":"trace[1816149185] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"901.14643ms","start":"2026-03-19T08:55:02.215886Z","end":"2026-03-19T08:55:03.117032Z","steps":["trace[1816149185] 'process raft request' (duration: 900.951345ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:03.117619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:02.215857Z","time spent":"901.701348ms","remote":"127.0.0.1:50918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-19T08:55:03.535958Z","caller":"traceutil/trace.go:171","msg":"trace[477719475] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"169.564656ms","start":"2026-03-19T08:55:03.36637Z","end":"2026-03-19T08:55:03.535935Z","steps":["trace[477719475] 'process raft request' (duration: 169.37192ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:05.792468Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.102441759s","expected-duration":"1s"} {"level":"warn","ts":"2026-03-19T08:55:07.86376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.815759743s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-19T08:55:07.863819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.204943386s","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-03-19T08:55:07.86388Z","caller":"traceutil/trace.go:171","msg":"trace[844028415] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"3.815895397s","start":"2026-03-19T08:55:04.047956Z","end":"2026-03-19T08:55:07.863851Z","steps":["trace[844028415] 'range keys from in-memory index tree' (duration: 3.815680642s)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:07.863904Z","caller":"traceutil/trace.go:171","msg":"trace[1318769970] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:597; }","duration":"4.20507812s","start":"2026-03-19T08:55:03.658801Z","end":"2026-03-19T08:55:07.863879Z","steps":["trace[1318769970] 'range keys from in-memory index tree' (duration: 4.20475159s)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:07.863942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:04.047906Z","time spent":"3.816027061s","remote":"127.0.0.1:50744","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-03-19T08:55:07.863964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:03.658778Z","time spent":"4.205176513s","remote":"127.0.0.1:51016","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-03-19T08:55:07.864194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.193454899s","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-03-19T08:55:07.864234Z","caller":"traceutil/trace.go:171","msg":"trace[1529056721] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:597; }","duration":"4.193530262s","start":"2026-03-19T08:55:03.670692Z","end":"2026-03-19T08:55:07.864223Z","steps":["trace[1529056721] 'range keys from in-memory index tree' (duration: 4.193332366s)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:07.864278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:03.67067Z","time spent":"4.193601514s","remote":"127.0.0.1:51016","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-03-19T08:55:07.864443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.193708116s","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-03-19T08:55:07.864478Z","caller":"traceutil/trace.go:171","msg":"trace[1736044894] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:597; }","duration":"4.193742587s","start":"2026-03-19T08:55:03.670727Z","end":"2026-03-19T08:55:07.86447Z","steps":["trace[1736044894] 'range keys from in-memory index tree' (duration: 4.193580433s)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:07.86451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:03.670674Z","time spent":"4.19382971s","remote":"127.0.0.1:51016","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-03-19T08:55:07.864763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.136047527s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-03-19T08:55:07.864802Z","caller":"traceutil/trace.go:171","msg":"trace[1796963196] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:597; }","duration":"4.136087078s","start":"2026-03-19T08:55:03.728706Z","end":"2026-03-19T08:55:07.864793Z","steps":["trace[1796963196] 'range keys from in-memory index tree' (duration: 4.135943174s)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:07.864836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:03.728649Z","time spent":"4.136179801s","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-19T08:55:08.04914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000268835s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-03-19T08:55:08.049235Z","caller":"traceutil/trace.go:171","msg":"trace[1526196167] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000424189s","start":"2026-03-19T08:55:06.04879Z","end":"2026-03-19T08:55:08.049214Z","steps":["trace[1526196167] 'agreement among raft nodes before linearized reading' (duration: 2.000303786s)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:08.049291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:06.048769Z","time spent":"2.000513452s","remote":"127.0.0.1:50750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-19T08:55:08.12703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.334373785s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-03-19T08:55:08.127225Z","caller":"traceutil/trace.go:171","msg":"trace[1276417632] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"256.973364ms","start":"2026-03-19T08:55:07.870237Z","end":"2026-03-19T08:55:08.12721Z","steps":["trace[1276417632] 'process raft request' (duration: 256.875781ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:08.127251Z","caller":"traceutil/trace.go:171","msg":"trace[1011618847] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:624; }","duration":"2.078373286s","start":"2026-03-19T08:55:06.048844Z","end":"2026-03-19T08:55:08.127217Z","steps":["trace[1011618847] 'read index received' (duration: 37.051µs)","trace[1011618847] 'applied index is now lower than readState.Index' (duration: 2.078333685s)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:55:08.302418Z","caller":"traceutil/trace.go:171","msg":"trace[703379065] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"431.598799ms","start":"2026-03-19T08:55:07.870785Z","end":"2026-03-19T08:55:08.302384Z","steps":["trace[703379065] 'process raft request' (duration: 394.803746ms)","trace[703379065] 'compare' (duration: 36.585257ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:55:08.302597Z","caller":"traceutil/trace.go:171","msg":"trace[1872415901] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"430.661851ms","start":"2026-03-19T08:55:07.871922Z","end":"2026-03-19T08:55:08.302584Z","steps":["trace[1872415901] 'process raft request' (duration: 430.585069ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:08.30259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:07.870764Z","time spent":"431.753622ms","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-19T08:55:08.302652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:07.871913Z","time spent":"430.708192ms","remote":"127.0.0.1:51016","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-03-19T08:55:08.302709Z","caller":"traceutil/trace.go:171","msg":"trace[2106542385] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"431.927437ms","start":"2026-03-19T08:55:07.870775Z","end":"2026-03-19T08:55:08.302702Z","steps":["trace[2106542385] 'process raft request' (duration: 431.550517ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:08.302698Z","caller":"traceutil/trace.go:171","msg":"trace[941056452] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:626; }","duration":"175.379776ms","start":"2026-03-19T08:55:08.127295Z","end":"2026-03-19T08:55:08.302675Z","steps":["trace[941056452] 'read index received' (duration: 138.329266ms)","trace[941056452] 'applied index is now lower than readState.Index' (duration: 37.04942ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T08:55:08.302739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:07.870733Z","time spent":"431.988739ms","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-19T08:55:08.302883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.764823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-19T08:55:08.302916Z","caller":"traceutil/trace.go:171","msg":"trace[1886449881] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:602; }","duration":"245.832176ms","start":"2026-03-19T08:55:08.057076Z","end":"2026-03-19T08:55:08.302908Z","steps":["trace[1886449881] 'agreement among raft nodes before linearized reading' (duration: 245.786524ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:08.302984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.702515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-19T08:55:08.303036Z","caller":"traceutil/trace.go:171","msg":"trace[828252572] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"250.29752ms","start":"2026-03-19T08:55:08.05273Z","end":"2026-03-19T08:55:08.303028Z","steps":["trace[828252572] 'process raft request' (duration: 249.817126ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:08.303043Z","caller":"traceutil/trace.go:171","msg":"trace[926188760] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:602; }","duration":"597.835348ms","start":"2026-03-19T08:55:07.705191Z","end":"2026-03-19T08:55:08.303027Z","steps":["trace[926188760] 'agreement among raft nodes before linearized reading' (duration: 597.711445ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:08.303088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:07.705164Z","time spent":"597.910391ms","remote":"127.0.0.1:51210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":3,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"warn","ts":"2026-03-19T08:55:09.459436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.143674ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-19T08:55:09.4596Z","caller":"traceutil/trace.go:171","msg":"trace[1511780737] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"150.598614ms","start":"2026-03-19T08:55:09.308966Z","end":"2026-03-19T08:55:09.459564Z","steps":["trace[1511780737] 'process raft request' (duration: 25.267605ms)","trace[1511780737] 'compare' (duration: 125.029871ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:55:09.736158Z","caller":"traceutil/trace.go:171","msg":"trace[754604353] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"214.397371ms","start":"2026-03-19T08:55:09.521737Z","end":"2026-03-19T08:55:09.736134Z","steps":["trace[754604353] 'process raft request' (duration: 214.290028ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:10.44263Z","caller":"traceutil/trace.go:171","msg":"trace[106036093] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"120.983906ms","start":"2026-03-19T08:55:10.321618Z","end":"2026-03-19T08:55:10.442602Z","steps":["trace[106036093] 'process raft request' (duration: 120.921964ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:10.442946Z","caller":"traceutil/trace.go:171","msg":"trace[41140409] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"121.50005ms","start":"2026-03-19T08:55:10.321417Z","end":"2026-03-19T08:55:10.442917Z","steps":["trace[41140409] 'process raft request' (duration: 120.965406ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:11.456106Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088155219154311999,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-19T08:55:11.628617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.552984ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-19T08:55:11.628691Z","caller":"traceutil/trace.go:171","msg":"trace[1250042754] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"672.78715ms","start":"2026-03-19T08:55:10.955891Z","end":"2026-03-19T08:55:11.628678Z","steps":["trace[1250042754] 'read index received' (duration: 503.061372ms)","trace[1250042754] 'applied index is now lower than readState.Index' (duration: 169.724978ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:55:11.628757Z","caller":"traceutil/trace.go:171","msg":"trace[1705940778] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"700.217487ms","start":"2026-03-19T08:55:10.928532Z","end":"2026-03-19T08:55:11.628749Z","steps":["trace[1705940778] 'process raft request' (duration: 530.494819ms)","trace[1705940778] 'compare' (duration: 169.468651ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T08:55:11.62879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:10.928501Z","time spent":"700.275829ms","remote":"127.0.0.1:50810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":763,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-19T08:55:11.628964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.067567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-19T08:55:11.628982Z","caller":"traceutil/trace.go:171","msg":"trace[561154949] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:618; }","duration":"673.131119ms","start":"2026-03-19T08:55:10.955846Z","end":"2026-03-19T08:55:11.628977Z","steps":["trace[561154949] 'agreement among raft nodes before linearized reading' (duration: 673.080358ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:11.628996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:10.955821Z","time spent":"673.17203ms","remote":"127.0.0.1:50996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-03-19T08:55:11.629094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.943723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-19T08:55:11.629227Z","caller":"traceutil/trace.go:171","msg":"trace[410521087] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"580.112277ms","start":"2026-03-19T08:55:11.049101Z","end":"2026-03-19T08:55:11.629213Z","steps":["trace[410521087] 'agreement among raft nodes before linearized reading' (duration: 579.950283ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:11.629545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:11.049078Z","time spent":"580.455116ms","remote":"127.0.0.1:50744","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-03-19T08:55:11.629423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.541009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-03-19T08:55:11.629782Z","caller":"traceutil/trace.go:171","msg":"trace[1102235025] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:618; }","duration":"187.951319ms","start":"2026-03-19T08:55:11.441816Z","end":"2026-03-19T08:55:11.629767Z","steps":["trace[1102235025] 'agreement among raft nodes before linearized reading' (duration: 187.455076ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:11.841255Z","caller":"traceutil/trace.go:171","msg":"trace[323539211] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"109.558956ms","start":"2026-03-19T08:55:11.731673Z","end":"2026-03-19T08:55:11.841231Z","steps":["trace[323539211] 'process raft request' (duration: 109.461884ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:12.642088Z","caller":"traceutil/trace.go:171","msg":"trace[798614068] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"134.500222ms","start":"2026-03-19T08:55:12.507561Z","end":"2026-03-19T08:55:12.642061Z","steps":["trace[798614068] 'process raft request' (duration: 133.439524ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:12.865639Z","caller":"traceutil/trace.go:171","msg":"trace[1242431632] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"210.918322ms","start":"2026-03-19T08:55:12.654698Z","end":"2026-03-19T08:55:12.865616Z","steps":["trace[1242431632] 'process raft request' (duration: 205.686462ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:12.944868Z","caller":"traceutil/trace.go:171","msg":"trace[228964131] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"283.975925ms","start":"2026-03-19T08:55:12.660862Z","end":"2026-03-19T08:55:12.944838Z","steps":["trace[228964131] 'process raft request' (duration: 283.749728ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:12.945548Z","caller":"traceutil/trace.go:171","msg":"trace[594934318] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"234.808631ms","start":"2026-03-19T08:55:12.710352Z","end":"2026-03-19T08:55:12.945161Z","steps":["trace[594934318] 'process raft request' (duration: 234.404869ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:12.950169Z","caller":"traceutil/trace.go:171","msg":"trace[1217824798] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"236.893776ms","start":"2026-03-19T08:55:12.713234Z","end":"2026-03-19T08:55:12.950127Z","steps":["trace[1217824798] 'process raft request' (duration: 231.741289ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:12.950903Z","caller":"traceutil/trace.go:171","msg":"trace[1736675339] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:668; }","duration":"240.053021ms","start":"2026-03-19T08:55:12.710599Z","end":"2026-03-19T08:55:12.950652Z","steps":["trace[1736675339] 'read index received' (duration: 149.917003ms)","trace[1736675339] 'applied index is now lower than readState.Index' (duration: 90.134588ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T08:55:12.951081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.465201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-9bvng\" ","response":"range_response_count:1 size:4679"} {"level":"info","ts":"2026-03-19T08:55:12.951124Z","caller":"traceutil/trace.go:171","msg":"trace[1210061358] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-9bvng; range_end:; response_count:1; response_revision:642; }","duration":"240.547254ms","start":"2026-03-19T08:55:12.710567Z","end":"2026-03-19T08:55:12.951114Z","steps":["trace[1210061358] 'agreement among raft nodes before linearized reading' (duration: 240.374729ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:13.286144Z","caller":"traceutil/trace.go:171","msg":"trace[1908735724] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"137.145966ms","start":"2026-03-19T08:55:13.148972Z","end":"2026-03-19T08:55:13.286118Z","steps":["trace[1908735724] 'process raft request' (duration: 136.954561ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:13.286312Z","caller":"traceutil/trace.go:171","msg":"trace[597726300] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"132.882883ms","start":"2026-03-19T08:55:13.153404Z","end":"2026-03-19T08:55:13.286287Z","steps":["trace[597726300] 'process raft request' (duration: 132.665447ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:13.310172Z","caller":"traceutil/trace.go:171","msg":"trace[526983934] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"128.96663ms","start":"2026-03-19T08:55:13.181173Z","end":"2026-03-19T08:55:13.310139Z","steps":["trace[526983934] 'process raft request' (duration: 128.781255ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:14.033393Z","caller":"traceutil/trace.go:171","msg":"trace[1423163718] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"156.711995ms","start":"2026-03-19T08:55:13.876656Z","end":"2026-03-19T08:55:14.033368Z","steps":["trace[1423163718] 'process raft request' (duration: 83.731124ms)","trace[1423163718] 'compare' (duration: 72.856668ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T08:55:14.619436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.690982ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-19T08:55:14.619536Z","caller":"traceutil/trace.go:171","msg":"trace[1710010747] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"480.976051ms","start":"2026-03-19T08:55:14.138542Z","end":"2026-03-19T08:55:14.619518Z","steps":["trace[1710010747] 'process raft request' (duration: 319.139645ms)","trace[1710010747] 'compare' (duration: 161.342433ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T08:55:14.619586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:14.138511Z","time spent":"481.053853ms","remote":"127.0.0.1:50796","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-03-19T08:55:14.802205Z","caller":"traceutil/trace.go:171","msg":"trace[377105195] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"662.386091ms","start":"2026-03-19T08:55:14.139783Z","end":"2026-03-19T08:55:14.802169Z","steps":["trace[377105195] 'process raft request' (duration: 629.216523ms)","trace[377105195] 'compare' (duration: 32.720636ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:55:14.802239Z","caller":"traceutil/trace.go:171","msg":"trace[978257227] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"613.08997ms","start":"2026-03-19T08:55:14.189108Z","end":"2026-03-19T08:55:14.802198Z","steps":["trace[978257227] 'process raft request' (duration: 612.938935ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:14.802371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:14.139753Z","time spent":"662.534375ms","remote":"127.0.0.1:50796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188228,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-19T08:55:14.802405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:14.189079Z","time spent":"613.247784ms","remote":"127.0.0.1:50810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-19T08:55:14.80225Z","caller":"traceutil/trace.go:171","msg":"trace[2071036263] linearizableReadLoop","detail":"{readStateIndex:706; appliedIndex:703; }","duration":"599.837014ms","start":"2026-03-19T08:55:14.202384Z","end":"2026-03-19T08:55:14.802221Z","steps":["trace[2071036263] 'read index received' (duration: 255.236963ms)","trace[2071036263] 'applied index is now lower than readState.Index' (duration: 344.596791ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T08:55:14.857282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.597834ms","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-03-19T08:55:14.857396Z","caller":"traceutil/trace.go:171","msg":"trace[1160747692] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:676; }","duration":"550.774679ms","start":"2026-03-19T08:55:14.306594Z","end":"2026-03-19T08:55:14.857368Z","steps":["trace[1160747692] 'agreement among raft nodes before linearized reading' (duration: 550.4504ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:14.857448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:14.306571Z","time spent":"550.866771ms","remote":"127.0.0.1:50796","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-03-19T08:55:14.857769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.331986ms","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-03-19T08:55:14.857809Z","caller":"traceutil/trace.go:171","msg":"trace[295145347] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:676; }","duration":"655.47841ms","start":"2026-03-19T08:55:14.202317Z","end":"2026-03-19T08:55:14.857796Z","steps":["trace[295145347] 'agreement among raft nodes before linearized reading' (duration: 599.985578ms)","trace[295145347] 'range keys from in-memory index tree' (duration: 55.308857ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T08:55:14.858034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:14.202293Z","time spent":"655.728267ms","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-19T08:55:14.858453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.327633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cgp7r\" ","response":"range_response_count:1 size:18333"} {"level":"info","ts":"2026-03-19T08:55:14.858489Z","caller":"traceutil/trace.go:171","msg":"trace[446615248] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cgp7r; range_end:; response_count:1; response_revision:676; }","duration":"122.394124ms","start":"2026-03-19T08:55:14.736085Z","end":"2026-03-19T08:55:14.858479Z","steps":["trace[446615248] 'agreement among raft nodes before linearized reading' (duration: 122.273001ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:14.858866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.036641ms","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-03-19T08:55:14.858904Z","caller":"traceutil/trace.go:171","msg":"trace[74335257] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:676; }","duration":"152.172224ms","start":"2026-03-19T08:55:14.706721Z","end":"2026-03-19T08:55:14.858893Z","steps":["trace[74335257] 'agreement among raft nodes before linearized reading' (duration: 152.0074ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:14.859053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.792711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-03-19T08:55:14.859142Z","caller":"traceutil/trace.go:171","msg":"trace[487201026] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:676; }","duration":"398.910954ms","start":"2026-03-19T08:55:14.460219Z","end":"2026-03-19T08:55:14.85913Z","steps":["trace[487201026] 'agreement among raft nodes before linearized reading' (duration: 398.74002ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:14.859196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:14.460205Z","time spent":"398.980536ms","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-19T08:55:14.859217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.137628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-03-19T08:55:14.859274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.230757ms","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-03-19T08:55:14.859307Z","caller":"traceutil/trace.go:171","msg":"trace[163788485] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:676; }","duration":"407.353704ms","start":"2026-03-19T08:55:14.451935Z","end":"2026-03-19T08:55:14.859289Z","steps":["trace[163788485] 'agreement among raft nodes before linearized reading' (duration: 407.126039ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:14.859362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:14.451915Z","time spent":"407.438087ms","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-03-19T08:55:14.859373Z","caller":"traceutil/trace.go:171","msg":"trace[1025506704] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:676; }","duration":"353.370921ms","start":"2026-03-19T08:55:14.505975Z","end":"2026-03-19T08:55:14.859346Z","steps":["trace[1025506704] 'agreement among raft nodes before linearized reading' (duration: 353.153035ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:14.859405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:14.505957Z","time spent":"353.440662ms","remote":"127.0.0.1:50796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":9343,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "} {"level":"warn","ts":"2026-03-19T08:55:14.859504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.740054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-19T08:55:14.859537Z","caller":"traceutil/trace.go:171","msg":"trace[125490029] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:676; }","duration":"347.778914ms","start":"2026-03-19T08:55:14.511743Z","end":"2026-03-19T08:55:14.859522Z","steps":["trace[125490029] 'agreement among raft nodes before linearized reading' (duration: 347.737823ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:14.859557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:14.511737Z","time spent":"347.814285ms","remote":"127.0.0.1:51244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-03-19T08:55:14.859701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.429328ms","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-03-19T08:55:14.859781Z","caller":"traceutil/trace.go:171","msg":"trace[755667721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:676; }","duration":"396.528961ms","start":"2026-03-19T08:55:14.463239Z","end":"2026-03-19T08:55:14.859768Z","steps":["trace[755667721] 'agreement among raft nodes before linearized reading' (duration: 396.254464ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:14.85985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:14.46323Z","time spent":"396.610613ms","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-19T08:55:15.335298Z","caller":"traceutil/trace.go:171","msg":"trace[1810509658] linearizableReadLoop","detail":"{readStateIndex:714; appliedIndex:713; }","duration":"286.434995ms","start":"2026-03-19T08:55:15.048835Z","end":"2026-03-19T08:55:15.33527Z","steps":["trace[1810509658] 'read index received' (duration: 227.964759ms)","trace[1810509658] 'applied index is now lower than readState.Index' (duration: 58.469226ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T08:55:15.335523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.668781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-19T08:55:15.335596Z","caller":"traceutil/trace.go:171","msg":"trace[1786069962] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:683; }","duration":"286.815784ms","start":"2026-03-19T08:55:15.048758Z","end":"2026-03-19T08:55:15.335573Z","steps":["trace[1786069962] 'agreement among raft nodes before linearized reading' (duration: 286.689491ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:15.335616Z","caller":"traceutil/trace.go:171","msg":"trace[1648623596] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"401.247768ms","start":"2026-03-19T08:55:14.934319Z","end":"2026-03-19T08:55:15.335567Z","steps":["trace[1648623596] 'process raft request' (duration: 342.601268ms)","trace[1648623596] 'compare' (duration: 58.182188ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T08:55:15.33579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T08:55:14.93431Z","time spent":"401.386291ms","remote":"127.0.0.1:50796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188237,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-19T08:55:15.335948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.191012ms","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":"warn","ts":"2026-03-19T08:55:15.335964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.764984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-19T08:55:15.336009Z","caller":"traceutil/trace.go:171","msg":"trace[1532986636] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:683; }","duration":"102.855947ms","start":"2026-03-19T08:55:15.233137Z","end":"2026-03-19T08:55:15.335993Z","steps":["trace[1532986636] 'agreement among raft nodes before linearized reading' (duration: 102.766655ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:15.336064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.463379ms","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":"warn","ts":"2026-03-19T08:55:15.336064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.184502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-19T08:55:15.336107Z","caller":"traceutil/trace.go:171","msg":"trace[1983108693] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:683; }","duration":"153.261844ms","start":"2026-03-19T08:55:15.182834Z","end":"2026-03-19T08:55:15.336096Z","steps":["trace[1983108693] 'agreement among raft nodes before linearized reading' (duration: 153.194382ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:15.336108Z","caller":"traceutil/trace.go:171","msg":"trace[383967397] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:683; }","duration":"138.554152ms","start":"2026-03-19T08:55:15.197538Z","end":"2026-03-19T08:55:15.336092Z","steps":["trace[383967397] 'agreement among raft nodes before linearized reading' (duration: 138.5013ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:15.336138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.457458ms","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":"warn","ts":"2026-03-19T08:55:15.33619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.11136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-03-19T08:55:15.336269Z","caller":"traceutil/trace.go:171","msg":"trace[935367098] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:683; }","duration":"138.643173ms","start":"2026-03-19T08:55:15.197586Z","end":"2026-03-19T08:55:15.336229Z","steps":["trace[935367098] 'agreement among raft nodes before linearized reading' (duration: 138.412527ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:15.336346Z","caller":"traceutil/trace.go:171","msg":"trace[1846758009] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:683; }","duration":"229.263763ms","start":"2026-03-19T08:55:15.107034Z","end":"2026-03-19T08:55:15.336297Z","steps":["trace[1846758009] 'agreement among raft nodes before linearized reading' (duration: 228.709469ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:15.33647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.606269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-19T08:55:15.336524Z","caller":"traceutil/trace.go:171","msg":"trace[779375383] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:683; }","duration":"102.673571ms","start":"2026-03-19T08:55:15.233836Z","end":"2026-03-19T08:55:15.33651Z","steps":["trace[779375383] 'agreement among raft nodes before linearized reading' (duration: 102.599729ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:15.336501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.624413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-19T08:55:15.335991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.721259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-19T08:55:15.336703Z","caller":"traceutil/trace.go:171","msg":"trace[111680330] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:683; }","duration":"153.459137ms","start":"2026-03-19T08:55:15.183234Z","end":"2026-03-19T08:55:15.336693Z","steps":["trace[111680330] 'agreement among raft nodes before linearized reading' (duration: 152.718458ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:15.336721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.725833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-19T08:55:15.336686Z","caller":"traceutil/trace.go:171","msg":"trace[604997414] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:683; }","duration":"153.851008ms","start":"2026-03-19T08:55:15.182822Z","end":"2026-03-19T08:55:15.336673Z","steps":["trace[604997414] 'agreement among raft nodes before linearized reading' (duration: 153.646143ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:15.336795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.122014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-19T08:55:15.336809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.841052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-19T08:55:15.336848Z","caller":"traceutil/trace.go:171","msg":"trace[204226992] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:683; }","duration":"103.893003ms","start":"2026-03-19T08:55:15.232946Z","end":"2026-03-19T08:55:15.336839Z","steps":["trace[204226992] 'agreement among raft nodes before linearized reading' (duration: 103.838801ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:15.336845Z","caller":"traceutil/trace.go:171","msg":"trace[149464643] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:683; }","duration":"120.194766ms","start":"2026-03-19T08:55:15.216639Z","end":"2026-03-19T08:55:15.336834Z","steps":["trace[149464643] 'agreement among raft nodes before linearized reading' (duration: 120.119994ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:15.337009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.518964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-19T08:55:15.337053Z","caller":"traceutil/trace.go:171","msg":"trace[1177599344] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:683; }","duration":"120.583516ms","start":"2026-03-19T08:55:15.216459Z","end":"2026-03-19T08:55:15.337042Z","steps":["trace[1177599344] 'agreement among raft nodes before linearized reading' (duration: 120.517324ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:15.336765Z","caller":"traceutil/trace.go:171","msg":"trace[746027039] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:683; }","duration":"119.769534ms","start":"2026-03-19T08:55:15.21698Z","end":"2026-03-19T08:55:15.33675Z","steps":["trace[746027039] 'agreement among raft nodes before linearized reading' (duration: 119.705483ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:15.335981Z","caller":"traceutil/trace.go:171","msg":"trace[2067365925] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:683; }","duration":"138.241933ms","start":"2026-03-19T08:55:15.197725Z","end":"2026-03-19T08:55:15.335967Z","steps":["trace[2067365925] 'agreement among raft nodes before linearized reading' (duration: 138.194612ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:15.567781Z","caller":"traceutil/trace.go:171","msg":"trace[595377251] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"120.072453ms","start":"2026-03-19T08:55:15.447679Z","end":"2026-03-19T08:55:15.567752Z","steps":["trace[595377251] 'process raft request' (duration: 119.757055ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:29.162042Z","caller":"traceutil/trace.go:171","msg":"trace[722565243] linearizableReadLoop","detail":"{readStateIndex:834; appliedIndex:833; }","duration":"172.945674ms","start":"2026-03-19T08:55:28.989071Z","end":"2026-03-19T08:55:29.162017Z","steps":["trace[722565243] 'read index received' (duration: 172.748018ms)","trace[722565243] 'applied index is now lower than readState.Index' (duration: 196.266µs)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:55:29.162119Z","caller":"traceutil/trace.go:171","msg":"trace[755127340] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"192.207974ms","start":"2026-03-19T08:55:28.969878Z","end":"2026-03-19T08:55:29.162086Z","steps":["trace[755127340] 'process raft request' (duration: 191.992238ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:29.162272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.183149ms","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-03-19T08:55:29.162323Z","caller":"traceutil/trace.go:171","msg":"trace[460215181] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:799; }","duration":"173.285001ms","start":"2026-03-19T08:55:28.989028Z","end":"2026-03-19T08:55:29.162313Z","steps":["trace[460215181] 'agreement among raft nodes before linearized reading' (duration: 173.122878ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:29.162395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.262576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-03-19T08:55:29.162449Z","caller":"traceutil/trace.go:171","msg":"trace[442694406] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:799; }","duration":"168.341887ms","start":"2026-03-19T08:55:28.994092Z","end":"2026-03-19T08:55:29.162434Z","steps":["trace[442694406] 'agreement among raft nodes before linearized reading' (duration: 168.173903ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:29.162535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.091379ms","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-03-19T08:55:29.162571Z","caller":"traceutil/trace.go:171","msg":"trace[226040437] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:799; }","duration":"167.14766ms","start":"2026-03-19T08:55:28.995413Z","end":"2026-03-19T08:55:29.162561Z","steps":["trace[226040437] 'agreement among raft nodes before linearized reading' (duration: 167.041157ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:37.345155Z","caller":"traceutil/trace.go:171","msg":"trace[1700768155] transaction","detail":"{read_only:false; response_revision:828; number_of_response:1; }","duration":"140.290653ms","start":"2026-03-19T08:55:37.20484Z","end":"2026-03-19T08:55:37.34513Z","steps":["trace[1700768155] 'process raft request' (duration: 140.050108ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:55:37.345243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.875051ms","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-03-19T08:55:37.345328Z","caller":"traceutil/trace.go:171","msg":"trace[1960354357] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:828; }","duration":"136.994173ms","start":"2026-03-19T08:55:37.208313Z","end":"2026-03-19T08:55:37.345307Z","steps":["trace[1960354357] 'agreement among raft nodes before linearized reading' (duration: 136.753098ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:55:37.440091Z","caller":"traceutil/trace.go:171","msg":"trace[2099481912] transaction","detail":"{read_only:false; response_revision:829; number_of_response:1; }","duration":"136.225587ms","start":"2026-03-19T08:55:37.303834Z","end":"2026-03-19T08:55:37.44006Z","steps":["trace[2099481912] 'process raft request' (duration: 57.542679ms)","trace[2099481912] 'compare' (duration: 78.543274ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:56:19.837631Z","caller":"traceutil/trace.go:171","msg":"trace[2144381734] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"178.418415ms","start":"2026-03-19T08:56:19.659181Z","end":"2026-03-19T08:56:19.837599Z","steps":["trace[2144381734] 'process raft request' (duration: 126.33947ms)","trace[2144381734] 'compare' (duration: 51.931363ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:56:19.888971Z","caller":"traceutil/trace.go:171","msg":"trace[1953326498] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"228.753012ms","start":"2026-03-19T08:56:19.660192Z","end":"2026-03-19T08:56:19.888945Z","steps":["trace[1953326498] 'process raft request' (duration: 228.565389ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:56:29.771804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.548269ms","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-03-19T08:56:29.771923Z","caller":"traceutil/trace.go:171","msg":"trace[1786983433] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1004; }","duration":"173.651061ms","start":"2026-03-19T08:56:29.598227Z","end":"2026-03-19T08:56:29.771878Z","steps":["trace[1786983433] 'range keys from in-memory index tree' (duration: 173.347966ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:56:29.875892Z","caller":"traceutil/trace.go:171","msg":"trace[254188641] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"100.707591ms","start":"2026-03-19T08:56:29.77516Z","end":"2026-03-19T08:56:29.875867Z","steps":["trace[254188641] 'process raft request' (duration: 100.556138ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:56:29.876572Z","caller":"traceutil/trace.go:171","msg":"trace[2029884974] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"100.316236ms","start":"2026-03-19T08:56:29.776232Z","end":"2026-03-19T08:56:29.876549Z","steps":["trace[2029884974] 'process raft request' (duration: 100.191144ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:56:44.241441Z","caller":"traceutil/trace.go:171","msg":"trace[623459500] linearizableReadLoop","detail":"{readStateIndex:1109; appliedIndex:1108; }","duration":"131.63054ms","start":"2026-03-19T08:56:44.109789Z","end":"2026-03-19T08:56:44.24142Z","steps":["trace[623459500] 'read index received' (duration: 119.940698ms)","trace[623459500] 'applied index is now lower than readState.Index' (duration: 11.689152ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:56:44.241539Z","caller":"traceutil/trace.go:171","msg":"trace[243297073] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"153.168545ms","start":"2026-03-19T08:56:44.088362Z","end":"2026-03-19T08:56:44.24153Z","steps":["trace[243297073] 'process raft request' (duration: 141.394812ms)","trace[243297073] 'compare' (duration: 11.5752ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T08:56:44.24167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.537269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:kubelet-serving-approver\" ","response":"range_response_count:1 size:682"} {"level":"info","ts":"2026-03-19T08:56:44.241708Z","caller":"traceutil/trace.go:171","msg":"trace[851246805] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:kubelet-serving-approver; range_end:; response_count:1; response_revision:1057; }","duration":"118.691141ms","start":"2026-03-19T08:56:44.123006Z","end":"2026-03-19T08:56:44.241697Z","steps":["trace[851246805] 'agreement among raft nodes before linearized reading' (duration: 118.59839ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:56:44.241739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.944094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:kube-apiserver-client-kubelet-approver\" ","response":"range_response_count:1 size:724"} {"level":"info","ts":"2026-03-19T08:56:44.241769Z","caller":"traceutil/trace.go:171","msg":"trace[358942199] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:kube-apiserver-client-kubelet-approver; range_end:; response_count:1; response_revision:1057; }","duration":"132.001594ms","start":"2026-03-19T08:56:44.109758Z","end":"2026-03-19T08:56:44.24176Z","steps":["trace[358942199] 'agreement among raft nodes before linearized reading' (duration: 131.947303ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:56:50.198193Z","caller":"traceutil/trace.go:171","msg":"trace[1809153794] linearizableReadLoop","detail":"{readStateIndex:1127; appliedIndex:1126; }","duration":"108.99301ms","start":"2026-03-19T08:56:50.089176Z","end":"2026-03-19T08:56:50.198169Z","steps":["trace[1809153794] 'read index received' (duration: 108.878968ms)","trace[1809153794] 'applied index is now lower than readState.Index' (duration: 112.681µs)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:56:50.198236Z","caller":"traceutil/trace.go:171","msg":"trace[659803116] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"134.054555ms","start":"2026-03-19T08:56:50.064148Z","end":"2026-03-19T08:56:50.198202Z","steps":["trace[659803116] 'process raft request' (duration: 133.857372ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:56:50.198392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.03328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:pod-garbage-collector\" ","response":"range_response_count:1 size:759"} {"level":"warn","ts":"2026-03-19T08:56:50.198397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.188912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:persistent-volume-binder\" ","response":"range_response_count:1 size:771"} {"level":"info","ts":"2026-03-19T08:56:50.19844Z","caller":"traceutil/trace.go:171","msg":"trace[1148773216] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:pod-garbage-collector; range_end:; response_count:1; response_revision:1073; }","duration":"106.102741ms","start":"2026-03-19T08:56:50.092322Z","end":"2026-03-19T08:56:50.198425Z","steps":["trace[1148773216] 'agreement among raft nodes before linearized reading' (duration: 106.00713ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:56:50.198481Z","caller":"traceutil/trace.go:171","msg":"trace[687733060] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:persistent-volume-binder; range_end:; response_count:1; response_revision:1073; }","duration":"109.317443ms","start":"2026-03-19T08:56:50.089142Z","end":"2026-03-19T08:56:50.19846Z","steps":["trace[687733060] 'agreement among raft nodes before linearized reading' (duration: 109.155651ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:56:50.373691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.198001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-03-19T08:56:50.373792Z","caller":"traceutil/trace.go:171","msg":"trace[1504956921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1074; }","duration":"106.372344ms","start":"2026-03-19T08:56:50.267396Z","end":"2026-03-19T08:56:50.373768Z","steps":["trace[1504956921] 'range keys from in-memory index tree' (duration: 106.021739ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:56:50.373783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.469325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:pod-garbage-collector\" ","response":"range_response_count:1 size:759"} {"level":"info","ts":"2026-03-19T08:56:50.373859Z","caller":"traceutil/trace.go:171","msg":"trace[1534916982] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:pod-garbage-collector; range_end:; response_count:1; response_revision:1074; }","duration":"103.556886ms","start":"2026-03-19T08:56:50.270281Z","end":"2026-03-19T08:56:50.373838Z","steps":["trace[1534916982] 'range keys from in-memory index tree' (duration: 103.342034ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:56:50.374368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.740199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:persistent-volume-binder\" ","response":"range_response_count:1 size:771"} {"level":"info","ts":"2026-03-19T08:56:50.374466Z","caller":"traceutil/trace.go:171","msg":"trace[619661740] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:persistent-volume-binder; range_end:; response_count:1; response_revision:1074; }","duration":"112.936961ms","start":"2026-03-19T08:56:50.261506Z","end":"2026-03-19T08:56:50.374443Z","steps":["trace[619661740] 'range keys from in-memory index tree' (duration: 111.992109ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T08:56:52.376079Z","caller":"traceutil/trace.go:171","msg":"trace[2051189910] linearizableReadLoop","detail":"{readStateIndex:1133; appliedIndex:1132; }","duration":"136.713534ms","start":"2026-03-19T08:56:52.239329Z","end":"2026-03-19T08:56:52.376043Z","steps":["trace[2051189910] 'read index received' (duration: 136.583063ms)","trace[2051189910] 'applied index is now lower than readState.Index' (duration: 129.531µs)"],"step_count":2} {"level":"info","ts":"2026-03-19T08:56:52.37621Z","caller":"traceutil/trace.go:171","msg":"trace[1180030027] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"169.663731ms","start":"2026-03-19T08:56:52.206535Z","end":"2026-03-19T08:56:52.376199Z","steps":["trace[1180030027] 'process raft request' (duration: 169.350187ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:56:52.37651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.70311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:monitoring\" ","response":"range_response_count:1 size:694"} {"level":"info","ts":"2026-03-19T08:56:52.376574Z","caller":"traceutil/trace.go:171","msg":"trace[610003114] range","detail":"{range_begin:/registry/clusterrolebindings/system:monitoring; range_end:; response_count:1; response_revision:1079; }","duration":"110.795421ms","start":"2026-03-19T08:56:52.265763Z","end":"2026-03-19T08:56:52.376559Z","steps":["trace[610003114] 'agreement among raft nodes before linearized reading' (duration: 110.661609ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:56:52.376711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.255732ms","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-03-19T08:56:52.376805Z","caller":"traceutil/trace.go:171","msg":"trace[1352505230] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1079; }","duration":"137.491275ms","start":"2026-03-19T08:56:52.239292Z","end":"2026-03-19T08:56:52.376783Z","steps":["trace[1352505230] 'agreement among raft nodes before linearized reading' (duration: 137.147601ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T08:56:52.376326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.948433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:node\" ","response":"range_response_count:1 size:603"} {"level":"info","ts":"2026-03-19T08:56:52.377011Z","caller":"traceutil/trace.go:171","msg":"trace[702793019] range","detail":"{range_begin:/registry/clusterrolebindings/system:node; range_end:; response_count:1; response_revision:1079; }","duration":"117.669972ms","start":"2026-03-19T08:56:52.25932Z","end":"2026-03-19T08:56:52.376989Z","steps":["trace[702793019] 'agreement among raft nodes before linearized reading' (duration: 116.945882ms)"],"step_count":1}