{"level":"warn","ts":"2026-02-25T01:41:54.874339Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-25T01:41:54.874429Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.116: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.116:2380","--initial-cluster=instance=https://199.204.45.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.116:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-02-25T01:41:54.87449Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-25T01:41:54.874502Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-02-25T01:41:54.874522Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-02-25T01:41:54.875181Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"]} {"level":"info","ts":"2026-02-25T01:41:54.875248Z","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":16,"max-cpu-available":16,"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.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.116:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-02-25T01:41:54.967265Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"91.753593ms"} {"level":"info","ts":"2026-02-25T01:41:54.97804Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5caa70ef1dd6dc04","cluster-id":"45afccab143d2c82"} {"level":"info","ts":"2026-02-25T01:41:54.978145Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=()"} {"level":"info","ts":"2026-02-25T01:41:54.978178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 0"} {"level":"info","ts":"2026-02-25T01:41:54.978196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5caa70ef1dd6dc04 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-25T01:41:54.978216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 1"} {"level":"info","ts":"2026-02-25T01:41:54.978272Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"warn","ts":"2026-02-25T01:41:54.989322Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-25T01:41:54.990923Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-25T01:41:54.992079Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-02-25T01:41:54.994761Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5caa70ef1dd6dc04","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-25T01:41:54.995121Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-25T01:41:54.995246Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-25T01:41:54.995275Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-25T01:41:54.995448Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5caa70ef1dd6dc04","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-25T01:41:54.996587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"info","ts":"2026-02-25T01:41:54.997637Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","added-peer-id":"5caa70ef1dd6dc04","added-peer-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-02-25T01:41:55.000962Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-02-25T01:41:55.001253Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5caa70ef1dd6dc04","initial-advertise-peer-urls":["https://199.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-25T01:41:55.001314Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-25T01:41:55.002187Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-02-25T01:41:55.002223Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-02-25T01:41:55.378707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 is starting a new election at term 1"} {"level":"info","ts":"2026-02-25T01:41:55.378761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-25T01:41:55.378787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgPreVoteResp from 5caa70ef1dd6dc04 at term 1"} {"level":"info","ts":"2026-02-25T01:41:55.378804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became candidate at term 2"} {"level":"info","ts":"2026-02-25T01:41:55.378813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgVoteResp from 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-02-25T01:41:55.378838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became leader at term 2"} {"level":"info","ts":"2026-02-25T01:41:55.378849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5caa70ef1dd6dc04 elected leader 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-02-25T01:41:55.380498Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5caa70ef1dd6dc04","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.116:2379]}","request-path":"/0/members/5caa70ef1dd6dc04/attributes","cluster-id":"45afccab143d2c82","publish-timeout":"7s"} {"level":"info","ts":"2026-02-25T01:41:55.382737Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T01:41:55.38281Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T01:41:55.382996Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-25T01:41:55.383104Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-25T01:41:55.385858Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.116:2379"} {"level":"info","ts":"2026-02-25T01:41:55.386091Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T01:41:55.386925Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T01:41:55.387269Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T01:41:55.387328Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T01:41:55.388223Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-02-25T01:42:03.434592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.824622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-02-25T01:42:03.435112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.242648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-25T01:42:03.435131Z","caller":"traceutil/trace.go:171","msg":"trace[769814324] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:273; }","duration":"339.471373ms","start":"2026-02-25T01:42:03.095635Z","end":"2026-02-25T01:42:03.435106Z","steps":["trace[769814324] 'range keys from in-memory index tree' (duration: 338.649717ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:03.435112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.649188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-02-25T01:42:03.43519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:03.095619Z","time spent":"339.560846ms","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-25T01:42:03.435235Z","caller":"traceutil/trace.go:171","msg":"trace[337444580] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:273; }","duration":"425.794652ms","start":"2026-02-25T01:42:03.009394Z","end":"2026-02-25T01:42:03.435188Z","steps":["trace[337444580] 'range keys from in-memory index tree' (duration: 425.521893ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:03.435183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.143753639s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-25T01:42:03.435468Z","caller":"traceutil/trace.go:171","msg":"trace[436641079] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:273; }","duration":"514.329561ms","start":"2026-02-25T01:42:02.920822Z","end":"2026-02-25T01:42:03.435152Z","steps":["trace[436641079] 'range keys from in-memory index tree' (duration: 513.962869ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:03.435474Z","caller":"traceutil/trace.go:171","msg":"trace[624177425] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:273; }","duration":"1.14407516s","start":"2026-02-25T01:42:02.291346Z","end":"2026-02-25T01:42:03.435421Z","steps":["trace[624177425] 'range keys from in-memory index tree' (duration: 1.143602534s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:03.435019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.235957191s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:1 size:205"} {"level":"warn","ts":"2026-02-25T01:42:03.435702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:02.920805Z","time spent":"514.712033ms","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-25T01:42:03.435733Z","caller":"traceutil/trace.go:171","msg":"trace[1792372777] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:1; response_revision:273; }","duration":"2.236714264s","start":"2026-02-25T01:42:01.198988Z","end":"2026-02-25T01:42:03.435702Z","steps":["trace[1792372777] 'range keys from in-memory index tree' (duration: 2.235857988s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:03.435292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:03.009376Z","time spent":"425.907225ms","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-25T01:42:03.435828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:01.19897Z","time spent":"2.236830188s","remote":"127.0.0.1:56056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":227,"request content":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" "} {"level":"warn","ts":"2026-02-25T01:42:03.43555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:02.291333Z","time spent":"1.144200234s","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-25T01:42:09.140476Z","caller":"traceutil/trace.go:171","msg":"trace[403251719] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"123.490924ms","start":"2026-02-25T01:42:09.016961Z","end":"2026-02-25T01:42:09.140452Z","steps":["trace[403251719] 'process raft request' (duration: 123.322679ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:13.826367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.832846ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-25T01:42:13.826637Z","caller":"traceutil/trace.go:171","msg":"trace[683626271] linearizableReadLoop","detail":"{readStateIndex:415; appliedIndex:414; }","duration":"316.636481ms","start":"2026-02-25T01:42:13.509963Z","end":"2026-02-25T01:42:13.8266Z","steps":["trace[683626271] 'read index received' (duration: 55.494025ms)","trace[683626271] 'applied index is now lower than readState.Index' (duration: 261.138376ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:42:13.826669Z","caller":"traceutil/trace.go:171","msg":"trace[446061934] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"313.838482ms","start":"2026-02-25T01:42:13.512807Z","end":"2026-02-25T01:42:13.826646Z","steps":["trace[446061934] 'process raft request' (duration: 313.701868ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:13.826756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.784865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-25T01:42:13.826795Z","caller":"traceutil/trace.go:171","msg":"trace[324898679] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:403; }","duration":"316.864848ms","start":"2026-02-25T01:42:13.509922Z","end":"2026-02-25T01:42:13.826787Z","steps":["trace[324898679] 'agreement among raft nodes before linearized reading' (duration: 316.790735ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:13.827016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:13.5098Z","time spent":"317.028023ms","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-25T01:42:13.827083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.518597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-25T01:42:13.827137Z","caller":"traceutil/trace.go:171","msg":"trace[779635848] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:403; }","duration":"316.642241ms","start":"2026-02-25T01:42:13.510479Z","end":"2026-02-25T01:42:13.827121Z","steps":["trace[779635848] 'agreement among raft nodes before linearized reading' (duration: 316.309191ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:13.827143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.370572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-25T01:42:13.827169Z","caller":"traceutil/trace.go:171","msg":"trace[509098394] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:403; }","duration":"316.418754ms","start":"2026-02-25T01:42:13.510743Z","end":"2026-02-25T01:42:13.827162Z","steps":["trace[509098394] 'agreement among raft nodes before linearized reading' (duration: 316.372942ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:13.827176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:13.510442Z","time spent":"316.726654ms","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-25T01:42:13.827211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:13.510729Z","time spent":"316.475546ms","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-25T01:42:13.827242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.606833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T01:42:13.827424Z","caller":"traceutil/trace.go:171","msg":"trace[543744412] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:403; }","duration":"194.86033ms","start":"2026-02-25T01:42:13.63251Z","end":"2026-02-25T01:42:13.82737Z","steps":["trace[543744412] 'agreement among raft nodes before linearized reading' (duration: 194.561671ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:13.827514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:13.512792Z","time spent":"313.996917ms","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:42:14.177382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.992999ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T01:42:14.177607Z","caller":"traceutil/trace.go:171","msg":"trace[1654100718] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"346.635799ms","start":"2026-02-25T01:42:13.830947Z","end":"2026-02-25T01:42:14.177583Z","steps":["trace[1654100718] 'process raft request' (duration: 235.343671ms)","trace[1654100718] 'compare' (duration: 110.873365ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:42:14.177682Z","caller":"traceutil/trace.go:171","msg":"trace[1105586986] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"346.66579ms","start":"2026-02-25T01:42:13.830976Z","end":"2026-02-25T01:42:14.177642Z","steps":["trace[1105586986] 'process raft request' (duration: 346.551227ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:14.177749Z","caller":"traceutil/trace.go:171","msg":"trace[1097108281] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"309.637679ms","start":"2026-02-25T01:42:13.86809Z","end":"2026-02-25T01:42:14.177727Z","steps":["trace[1097108281] 'process raft request' (duration: 309.482264ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:14.177832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:13.868068Z","time spent":"309.716232ms","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:42:14.17764Z","caller":"traceutil/trace.go:171","msg":"trace[876710599] linearizableReadLoop","detail":"{readStateIndex:419; appliedIndex:416; }","duration":"172.393501ms","start":"2026-02-25T01:42:14.005234Z","end":"2026-02-25T01:42:14.177628Z","steps":["trace[876710599] 'read index received' (duration: 61.088092ms)","trace[876710599] 'applied index is now lower than readState.Index' (duration: 111.304589ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:42:14.177903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.655329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/coredns-77cccfdc44-67pqq.189759d108533996\" ","response":"range_response_count:1 size:845"} {"level":"warn","ts":"2026-02-25T01:42:14.177931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:13.830953Z","time spent":"346.832235ms","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:42:14.177958Z","caller":"traceutil/trace.go:171","msg":"trace[479810480] range","detail":"{range_begin:/registry/events/kube-system/coredns-77cccfdc44-67pqq.189759d108533996; range_end:; response_count:1; response_revision:406; }","duration":"172.731442ms","start":"2026-02-25T01:42:14.005207Z","end":"2026-02-25T01:42:14.177938Z","steps":["trace[479810480] 'agreement among raft nodes before linearized reading' (duration: 172.623228ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:14.177696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:13.830922Z","time spent":"346.732092ms","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:42:20.309367Z","caller":"traceutil/trace.go:171","msg":"trace[1919318620] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"105.565388ms","start":"2026-02-25T01:42:20.203781Z","end":"2026-02-25T01:42:20.309346Z","steps":["trace[1919318620] 'process raft request' (duration: 105.430323ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:20.316106Z","caller":"traceutil/trace.go:171","msg":"trace[1482758049] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"111.854087ms","start":"2026-02-25T01:42:20.204232Z","end":"2026-02-25T01:42:20.316086Z","steps":["trace[1482758049] 'process raft request' (duration: 111.65726ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:20.316047Z","caller":"traceutil/trace.go:171","msg":"trace[1107624648] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"111.178235ms","start":"2026-02-25T01:42:20.204848Z","end":"2026-02-25T01:42:20.316026Z","steps":["trace[1107624648] 'process raft request' (duration: 111.120083ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:26.268878Z","caller":"traceutil/trace.go:171","msg":"trace[15130001] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"304.011892ms","start":"2026-02-25T01:42:25.964844Z","end":"2026-02-25T01:42:26.268856Z","steps":["trace[15130001] 'process raft request' (duration: 303.872918ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:26.269035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:25.964827Z","time spent":"304.133195ms","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:42:28.542567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.202751689s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-25T01:42:28.54266Z","caller":"traceutil/trace.go:171","msg":"trace[928187661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:466; }","duration":"2.202891214s","start":"2026-02-25T01:42:26.339749Z","end":"2026-02-25T01:42:28.542641Z","steps":["trace[928187661] 'range keys from in-memory index tree' (duration: 2.202598655s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:28.542703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:26.339732Z","time spent":"2.202961536s","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-25T01:42:28.542715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.199697483s","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-02-25T01:42:28.542736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.198848977s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-02-25T01:42:28.542756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:27.213298Z","time spent":"1.32945182s","remote":"127.0.0.1:53434","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-25T01:42:28.542763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.05443363s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4025"} {"level":"info","ts":"2026-02-25T01:42:28.542815Z","caller":"traceutil/trace.go:171","msg":"trace[1916700699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:466; }","duration":"2.199869679s","start":"2026-02-25T01:42:26.342918Z","end":"2026-02-25T01:42:28.542788Z","steps":["trace[1916700699] 'range keys from in-memory index tree' (duration: 2.19956893s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:28.542816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.90955326s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T01:42:28.542829Z","caller":"traceutil/trace.go:171","msg":"trace[771035882] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:466; }","duration":"2.1989683s","start":"2026-02-25T01:42:26.343825Z","end":"2026-02-25T01:42:28.542793Z","steps":["trace[771035882] 'range keys from in-memory index tree' (duration: 2.198756034s)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:28.542851Z","caller":"traceutil/trace.go:171","msg":"trace[1912560834] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:466; }","duration":"2.054567734s","start":"2026-02-25T01:42:26.488262Z","end":"2026-02-25T01:42:28.542829Z","steps":["trace[1912560834] 'range keys from in-memory index tree' (duration: 2.054293117s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:28.542864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:26.342897Z","time spent":"2.199957531s","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-25T01:42:28.54288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:26.343807Z","time spent":"2.199064733s","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-25T01:42:28.542882Z","caller":"traceutil/trace.go:171","msg":"trace[843447028] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:466; }","duration":"1.909677195s","start":"2026-02-25T01:42:26.633188Z","end":"2026-02-25T01:42:28.542866Z","steps":["trace[843447028] 'range keys from in-memory index tree' (duration: 1.909431397s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:28.542893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:26.488244Z","time spent":"2.054640977s","remote":"127.0.0.1:56020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4047,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-25T01:42:28.542927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:26.633166Z","time spent":"1.909751576s","remote":"127.0.0.1:55850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-25T01:42:28.548464Z","caller":"traceutil/trace.go:171","msg":"trace[711887015] linearizableReadLoop","detail":"{readStateIndex:482; appliedIndex:481; }","duration":"275.419138ms","start":"2026-02-25T01:42:28.273017Z","end":"2026-02-25T01:42:28.548437Z","steps":["trace[711887015] 'read index received' (duration: 275.196221ms)","trace[711887015] 'applied index is now lower than readState.Index' (duration: 221.747µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:42:28.548847Z","caller":"traceutil/trace.go:171","msg":"trace[1338665904] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"1.286690078s","start":"2026-02-25T01:42:27.262141Z","end":"2026-02-25T01:42:28.548831Z","steps":["trace[1338665904] 'process raft request' (duration: 1.28612057s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:28.549004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:27.262119Z","time spent":"1.286766061s","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:42:28.549043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.002386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-25T01:42:28.549108Z","caller":"traceutil/trace.go:171","msg":"trace[660440627] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:467; }","duration":"276.11715ms","start":"2026-02-25T01:42:28.272975Z","end":"2026-02-25T01:42:28.549092Z","steps":["trace[660440627] 'agreement among raft nodes before linearized reading' (duration: 275.904413ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:28.552495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.900808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.116\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-25T01:42:28.552546Z","caller":"traceutil/trace.go:171","msg":"trace[983169772] range","detail":"{range_begin:/registry/masterleases/199.204.45.116; range_end:; response_count:1; response_revision:468; }","duration":"210.997111ms","start":"2026-02-25T01:42:28.341537Z","end":"2026-02-25T01:42:28.552534Z","steps":["trace[983169772] 'agreement among raft nodes before linearized reading' (duration: 210.907579ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:36.934716Z","caller":"traceutil/trace.go:171","msg":"trace[616127153] linearizableReadLoop","detail":"{readStateIndex:529; appliedIndex:528; }","duration":"345.955198ms","start":"2026-02-25T01:42:36.588742Z","end":"2026-02-25T01:42:36.934697Z","steps":["trace[616127153] 'read index received' (duration: 345.802823ms)","trace[616127153] 'applied index is now lower than readState.Index' (duration: 151.505µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:42:36.934779Z","caller":"traceutil/trace.go:171","msg":"trace[1632330341] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"830.531088ms","start":"2026-02-25T01:42:36.104224Z","end":"2026-02-25T01:42:36.934755Z","steps":["trace[1632330341] 'process raft request' (duration: 830.339952ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:36.934959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:36.104206Z","time spent":"830.642521ms","remote":"127.0.0.1:56034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:42:36.934974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.210525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-25T01:42:36.935004Z","caller":"traceutil/trace.go:171","msg":"trace[1422258589] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:512; }","duration":"346.311749ms","start":"2026-02-25T01:42:36.588683Z","end":"2026-02-25T01:42:36.934995Z","steps":["trace[1422258589] 'agreement among raft nodes before linearized reading' (duration: 346.117673ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:36.93503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:36.588658Z","time spent":"346.366041ms","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-25T01:42:36.935017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.038711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T01:42:36.935092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.202911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-25T01:42:36.935118Z","caller":"traceutil/trace.go:171","msg":"trace[603640106] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:512; }","duration":"303.200016ms","start":"2026-02-25T01:42:36.631895Z","end":"2026-02-25T01:42:36.935095Z","steps":["trace[603640106] 'agreement among raft nodes before linearized reading' (duration: 303.020781ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:36.935132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.980363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-25T01:42:36.935178Z","caller":"traceutil/trace.go:171","msg":"trace[632604010] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:512; }","duration":"287.302753ms","start":"2026-02-25T01:42:36.64783Z","end":"2026-02-25T01:42:36.935133Z","steps":["trace[632604010] 'agreement among raft nodes before linearized reading' (duration: 287.109047ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:36.935211Z","caller":"traceutil/trace.go:171","msg":"trace[482595632] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:512; }","duration":"256.078116ms","start":"2026-02-25T01:42:36.679125Z","end":"2026-02-25T01:42:36.935203Z","steps":["trace[482595632] 'agreement among raft nodes before linearized reading' (duration: 255.941801ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:36.935279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:36.631874Z","time spent":"303.30089ms","remote":"127.0.0.1:55850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-25T01:42:36.935351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.47507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-25T01:42:36.935487Z","caller":"traceutil/trace.go:171","msg":"trace[983516906] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:512; }","duration":"288.604594ms","start":"2026-02-25T01:42:36.646846Z","end":"2026-02-25T01:42:36.935451Z","steps":["trace[983516906] 'agreement among raft nodes before linearized reading' (duration: 288.298245ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:37.739387Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853968741105313393,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-25T01:42:38.087056Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.134607542s","expected-duration":"1s"} {"level":"info","ts":"2026-02-25T01:42:38.087597Z","caller":"traceutil/trace.go:171","msg":"trace[626229664] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"1.14755576s","start":"2026-02-25T01:42:36.940023Z","end":"2026-02-25T01:42:38.087578Z","steps":["trace[626229664] 'process raft request' (duration: 1.147486358s)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:38.087632Z","caller":"traceutil/trace.go:171","msg":"trace[1646151974] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"1.148001684s","start":"2026-02-25T01:42:36.939607Z","end":"2026-02-25T01:42:38.087609Z","steps":["trace[1646151974] 'process raft request' (duration: 1.147690505s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:38.087724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:36.940014Z","time spent":"1.147642703s","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:42:38.087718Z","caller":"traceutil/trace.go:171","msg":"trace[510424269] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:530; }","duration":"849.132326ms","start":"2026-02-25T01:42:37.238564Z","end":"2026-02-25T01:42:38.087697Z","steps":["trace[510424269] 'read index received' (duration: 848.672972ms)","trace[510424269] 'applied index is now lower than readState.Index' (duration: 457.494µs)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:42:38.087734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:36.939593Z","time spent":"1.148084968s","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:42:38.087917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"849.356813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager-cainjector\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T01:42:38.087923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.226931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T01:42:38.087908Z","caller":"traceutil/trace.go:171","msg":"trace[952288043] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"1.147746187s","start":"2026-02-25T01:42:36.940104Z","end":"2026-02-25T01:42:38.08785Z","steps":["trace[952288043] 'process raft request' (duration: 1.147444158s)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:38.087954Z","caller":"traceutil/trace.go:171","msg":"trace[1294309821] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager-cainjector; range_end:; response_count:0; response_revision:516; }","duration":"849.423825ms","start":"2026-02-25T01:42:37.23852Z","end":"2026-02-25T01:42:38.087944Z","steps":["trace[1294309821] 'agreement among raft nodes before linearized reading' (duration: 849.336182ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:38.087999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:37.238506Z","time spent":"849.486998ms","remote":"127.0.0.1:56056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/cert-manager/cert-manager-cainjector\" "} {"level":"info","ts":"2026-02-25T01:42:38.087989Z","caller":"traceutil/trace.go:171","msg":"trace[1060530834] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:516; }","duration":"454.335084ms","start":"2026-02-25T01:42:37.633639Z","end":"2026-02-25T01:42:38.087974Z","steps":["trace[1060530834] 'agreement among raft nodes before linearized reading' (duration: 454.233881ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:38.08804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:37.633619Z","time spent":"454.408357ms","remote":"127.0.0.1:55850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-25T01:42:38.088123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:36.940087Z","time spent":"1.147925452s","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:42:38.397008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.938452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/issuers.cert-manager.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T01:42:38.397131Z","caller":"traceutil/trace.go:171","msg":"trace[926571003] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/issuers.cert-manager.io; range_end:; response_count:0; response_revision:516; }","duration":"294.149129ms","start":"2026-02-25T01:42:38.102948Z","end":"2026-02-25T01:42:38.397097Z","steps":["trace[926571003] 'range keys from in-memory index tree' (duration: 293.86881ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:38.862705Z","caller":"traceutil/trace.go:171","msg":"trace[899543508] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"169.112646ms","start":"2026-02-25T01:42:38.693558Z","end":"2026-02-25T01:42:38.862671Z","steps":["trace[899543508] 'process raft request' (duration: 142.564677ms)","trace[899543508] 'compare' (duration: 26.408645ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:42:38.865227Z","caller":"traceutil/trace.go:171","msg":"trace[9732391] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"171.256535ms","start":"2026-02-25T01:42:38.69396Z","end":"2026-02-25T01:42:38.865216Z","steps":["trace[9732391] 'process raft request' (duration: 171.0932ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:38.865429Z","caller":"traceutil/trace.go:171","msg":"trace[526634471] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"166.347389ms","start":"2026-02-25T01:42:38.699058Z","end":"2026-02-25T01:42:38.865405Z","steps":["trace[526634471] 'process raft request' (duration: 166.134842ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:38.865442Z","caller":"traceutil/trace.go:171","msg":"trace[1467216142] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"162.89712ms","start":"2026-02-25T01:42:38.702512Z","end":"2026-02-25T01:42:38.865409Z","steps":["trace[1467216142] 'process raft request' (duration: 162.775116ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:38.865525Z","caller":"traceutil/trace.go:171","msg":"trace[557807087] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"162.085164ms","start":"2026-02-25T01:42:38.703431Z","end":"2026-02-25T01:42:38.865516Z","steps":["trace[557807087] 'process raft request' (duration: 161.920789ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:38.865506Z","caller":"traceutil/trace.go:171","msg":"trace[1395442869] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"169.2373ms","start":"2026-02-25T01:42:38.696241Z","end":"2026-02-25T01:42:38.865478Z","steps":["trace[1395442869] 'process raft request' (duration: 168.9143ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:38.865524Z","caller":"traceutil/trace.go:171","msg":"trace[1721326168] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"158.627584ms","start":"2026-02-25T01:42:38.706867Z","end":"2026-02-25T01:42:38.865495Z","steps":["trace[1721326168] 'process raft request' (duration: 158.536792ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:39.228935Z","caller":"traceutil/trace.go:171","msg":"trace[136923436] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"108.014435ms","start":"2026-02-25T01:42:39.12088Z","end":"2026-02-25T01:42:39.228895Z","steps":["trace[136923436] 'process raft request' (duration: 107.836569ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:39.228982Z","caller":"traceutil/trace.go:171","msg":"trace[2091618633] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"108.040655ms","start":"2026-02-25T01:42:39.120914Z","end":"2026-02-25T01:42:39.228955Z","steps":["trace[2091618633] 'process raft request' (duration: 107.910201ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:39.434166Z","caller":"traceutil/trace.go:171","msg":"trace[1548172232] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"181.323553ms","start":"2026-02-25T01:42:39.25281Z","end":"2026-02-25T01:42:39.434133Z","steps":["trace[1548172232] 'process raft request' (duration: 174.869838ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:39.434329Z","caller":"traceutil/trace.go:171","msg":"trace[1528659868] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"181.049674ms","start":"2026-02-25T01:42:39.253263Z","end":"2026-02-25T01:42:39.434312Z","steps":["trace[1528659868] 'process raft request' (duration: 180.894199ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:39.434386Z","caller":"traceutil/trace.go:171","msg":"trace[1275196367] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"181.102936ms","start":"2026-02-25T01:42:39.253111Z","end":"2026-02-25T01:42:39.434214Z","steps":["trace[1275196367] 'process raft request' (duration: 180.91747ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:39.435851Z","caller":"traceutil/trace.go:171","msg":"trace[2051900171] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:617; }","duration":"171.44509ms","start":"2026-02-25T01:42:39.26439Z","end":"2026-02-25T01:42:39.435835Z","steps":["trace[2051900171] 'read index received' (duration: 163.319673ms)","trace[2051900171] 'applied index is now lower than readState.Index' (duration: 8.123917ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:42:39.436156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.73558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/cert-manager/cert-manager\" ","response":"range_response_count:1 size:4330"} {"level":"info","ts":"2026-02-25T01:42:39.437438Z","caller":"traceutil/trace.go:171","msg":"trace[301338115] range","detail":"{range_begin:/registry/deployments/cert-manager/cert-manager; range_end:; response_count:1; response_revision:606; }","duration":"173.076042ms","start":"2026-02-25T01:42:39.264339Z","end":"2026-02-25T01:42:39.437415Z","steps":["trace[301338115] 'agreement among raft nodes before linearized reading' (duration: 171.612276ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:39.436249Z","caller":"traceutil/trace.go:171","msg":"trace[1122507788] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"177.644337ms","start":"2026-02-25T01:42:39.258518Z","end":"2026-02-25T01:42:39.436162Z","steps":["trace[1122507788] 'process raft request' (duration: 177.201783ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:39.436407Z","caller":"traceutil/trace.go:171","msg":"trace[1270231004] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"177.821492ms","start":"2026-02-25T01:42:39.258578Z","end":"2026-02-25T01:42:39.436399Z","steps":["trace[1270231004] 'process raft request' (duration: 177.180422ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:39.436439Z","caller":"traceutil/trace.go:171","msg":"trace[829301680] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"172.37131ms","start":"2026-02-25T01:42:39.264063Z","end":"2026-02-25T01:42:39.436434Z","steps":["trace[829301680] 'process raft request' (duration: 171.7286ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:39.437457Z","caller":"traceutil/trace.go:171","msg":"trace[1402313777] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"179.01579ms","start":"2026-02-25T01:42:39.258417Z","end":"2026-02-25T01:42:39.437433Z","steps":["trace[1402313777] 'process raft request' (duration: 177.229243ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:39.640016Z","caller":"traceutil/trace.go:171","msg":"trace[401507182] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"196.206253ms","start":"2026-02-25T01:42:39.44377Z","end":"2026-02-25T01:42:39.639976Z","steps":["trace[401507182] 'process raft request' (duration: 120.17356ms)","trace[401507182] 'compare' (duration: 75.828117ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:42:39.640059Z","caller":"traceutil/trace.go:171","msg":"trace[1846234335] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"195.79921ms","start":"2026-02-25T01:42:39.444245Z","end":"2026-02-25T01:42:39.640044Z","steps":["trace[1846234335] 'process raft request' (duration: 195.733558ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:39.640074Z","caller":"traceutil/trace.go:171","msg":"trace[438869896] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"195.980777ms","start":"2026-02-25T01:42:39.444068Z","end":"2026-02-25T01:42:39.640049Z","steps":["trace[438869896] 'process raft request' (duration: 195.884554ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:39.640071Z","caller":"traceutil/trace.go:171","msg":"trace[1616046817] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"196.019377ms","start":"2026-02-25T01:42:39.444019Z","end":"2026-02-25T01:42:39.640038Z","steps":["trace[1616046817] 'process raft request' (duration: 195.888423ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:39.640463Z","caller":"traceutil/trace.go:171","msg":"trace[1952164274] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"194.915522ms","start":"2026-02-25T01:42:39.445536Z","end":"2026-02-25T01:42:39.640452Z","steps":["trace[1952164274] 'process raft request' (duration: 194.469068ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:39.640526Z","caller":"traceutil/trace.go:171","msg":"trace[1920982387] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"194.928143ms","start":"2026-02-25T01:42:39.445582Z","end":"2026-02-25T01:42:39.64051Z","steps":["trace[1920982387] 'process raft request' (duration: 194.737937ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:39.640587Z","caller":"traceutil/trace.go:171","msg":"trace[1036582170] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:626; }","duration":"193.610921ms","start":"2026-02-25T01:42:39.446961Z","end":"2026-02-25T01:42:39.640572Z","steps":["trace[1036582170] 'read index received' (duration: 85.820583ms)","trace[1036582170] 'applied index is now lower than readState.Index' (duration: 107.783478ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:42:39.640628Z","caller":"traceutil/trace.go:171","msg":"trace[2127976888] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"192.281639ms","start":"2026-02-25T01:42:39.448337Z","end":"2026-02-25T01:42:39.640619Z","steps":["trace[2127976888] 'process raft request' (duration: 192.124174ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:39.640658Z","caller":"traceutil/trace.go:171","msg":"trace[758084056] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"194.760398ms","start":"2026-02-25T01:42:39.44589Z","end":"2026-02-25T01:42:39.640651Z","steps":["trace[758084056] 'process raft request' (duration: 194.52872ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:39.640669Z","caller":"traceutil/trace.go:171","msg":"trace[215147807] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"191.266447ms","start":"2026-02-25T01:42:39.449394Z","end":"2026-02-25T01:42:39.64066Z","steps":["trace[215147807] 'process raft request' (duration: 191.109312ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:39.640711Z","caller":"traceutil/trace.go:171","msg":"trace[1544017395] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"104.186214ms","start":"2026-02-25T01:42:39.536507Z","end":"2026-02-25T01:42:39.640693Z","steps":["trace[1544017395] 'process raft request' (duration: 104.035339ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:39.640788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.815577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager-startupapicheck\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T01:42:39.640819Z","caller":"traceutil/trace.go:171","msg":"trace[2110518295] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager-startupapicheck; range_end:; response_count:0; response_revision:618; }","duration":"193.88819ms","start":"2026-02-25T01:42:39.44692Z","end":"2026-02-25T01:42:39.640808Z","steps":["trace[2110518295] 'agreement among raft nodes before linearized reading' (duration: 193.806407ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:40.093251Z","caller":"traceutil/trace.go:171","msg":"trace[225773073] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"447.299002ms","start":"2026-02-25T01:42:39.645931Z","end":"2026-02-25T01:42:40.09323Z","steps":["trace[225773073] 'process raft request' (duration: 422.176838ms)","trace[225773073] 'compare' (duration: 24.906088ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:42:40.09336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:39.645904Z","time spent":"447.402435ms","remote":"127.0.0.1:55938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":700,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T01:42:40.093392Z","caller":"traceutil/trace.go:171","msg":"trace[1779250030] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"447.342993ms","start":"2026-02-25T01:42:39.646018Z","end":"2026-02-25T01:42:40.093361Z","steps":["trace[1779250030] 'process raft request' (duration: 447.162148ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:40.093435Z","caller":"traceutil/trace.go:171","msg":"trace[1284588072] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:636; }","duration":"445.626239ms","start":"2026-02-25T01:42:39.647786Z","end":"2026-02-25T01:42:40.093413Z","steps":["trace[1284588072] 'read index received' (duration: 87.792886ms)","trace[1284588072] 'applied index is now lower than readState.Index' (duration: 357.832453ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:42:40.093449Z","caller":"traceutil/trace.go:171","msg":"trace[2000397966] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"447.121686ms","start":"2026-02-25T01:42:39.646301Z","end":"2026-02-25T01:42:40.093423Z","steps":["trace[2000397966] 'process raft request' (duration: 446.963021ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:40.09348Z","caller":"traceutil/trace.go:171","msg":"trace[447669855] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"445.33904ms","start":"2026-02-25T01:42:39.648116Z","end":"2026-02-25T01:42:40.093455Z","steps":["trace[447669855] 'process raft request' (duration: 445.207096ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:40.093545Z","caller":"traceutil/trace.go:171","msg":"trace[7947634] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"444.945538ms","start":"2026-02-25T01:42:39.648587Z","end":"2026-02-25T01:42:40.093532Z","steps":["trace[7947634] 'process raft request' (duration: 444.785573ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:40.093541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:39.645995Z","time spent":"447.470418ms","remote":"127.0.0.1:55938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":872,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T01:42:40.093622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:39.646282Z","time spent":"447.25308ms","remote":"127.0.0.1:56034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4229,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:42:40.093623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:39.648107Z","time spent":"445.434383ms","remote":"127.0.0.1:56366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3574,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:42:40.093653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:39.648581Z","time spent":"444.994849ms","remote":"127.0.0.1:56366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4698,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:42:40.093707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.929939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/cert-manager/cert-manager-7dbd7dcb7f\" ","response":"range_response_count:1 size:4381"} {"level":"info","ts":"2026-02-25T01:42:40.093792Z","caller":"traceutil/trace.go:171","msg":"trace[1777486408] range","detail":"{range_begin:/registry/replicasets/cert-manager/cert-manager-7dbd7dcb7f; range_end:; response_count:1; response_revision:624; }","duration":"446.039582ms","start":"2026-02-25T01:42:39.647743Z","end":"2026-02-25T01:42:40.093783Z","steps":["trace[1777486408] 'agreement among raft nodes before linearized reading' (duration: 445.862626ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:40.093837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:39.647736Z","time spent":"446.095754ms","remote":"127.0.0.1:56366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":4403,"request content":"key:\"/registry/replicasets/cert-manager/cert-manager-7dbd7dcb7f\" "} {"level":"info","ts":"2026-02-25T01:42:40.110715Z","caller":"traceutil/trace.go:171","msg":"trace[1491463278] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"361.959374ms","start":"2026-02-25T01:42:39.748721Z","end":"2026-02-25T01:42:40.110681Z","steps":["trace[1491463278] 'process raft request' (duration: 361.672845ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:40.110841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:39.748692Z","time spent":"362.075178ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":211522,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:42:40.299541Z","caller":"traceutil/trace.go:171","msg":"trace[1057969888] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"184.818933ms","start":"2026-02-25T01:42:40.1147Z","end":"2026-02-25T01:42:40.299519Z","steps":["trace[1057969888] 'process raft request' (duration: 184.736271ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:40.299589Z","caller":"traceutil/trace.go:171","msg":"trace[121761085] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"185.027989ms","start":"2026-02-25T01:42:40.114528Z","end":"2026-02-25T01:42:40.299556Z","steps":["trace[121761085] 'process raft request' (duration: 184.854874ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:40.299619Z","caller":"traceutil/trace.go:171","msg":"trace[408935174] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"186.841597ms","start":"2026-02-25T01:42:40.112752Z","end":"2026-02-25T01:42:40.299593Z","steps":["trace[408935174] 'process raft request' (duration: 105.30495ms)","trace[408935174] 'compare' (duration: 81.192787ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:42:40.299865Z","caller":"traceutil/trace.go:171","msg":"trace[858050778] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"173.446103ms","start":"2026-02-25T01:42:40.126395Z","end":"2026-02-25T01:42:40.299841Z","steps":["trace[858050778] 'process raft request' (duration: 173.33646ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:40.299871Z","caller":"traceutil/trace.go:171","msg":"trace[404073153] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"184.351008ms","start":"2026-02-25T01:42:40.115495Z","end":"2026-02-25T01:42:40.299846Z","steps":["trace[404073153] 'process raft request' (duration: 183.991507ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:40.359724Z","caller":"traceutil/trace.go:171","msg":"trace[1013283977] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"169.759888ms","start":"2026-02-25T01:42:40.189932Z","end":"2026-02-25T01:42:40.359692Z","steps":["trace[1013283977] 'process raft request' (duration: 169.550521ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:40.359752Z","caller":"traceutil/trace.go:171","msg":"trace[1548753393] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"176.642725ms","start":"2026-02-25T01:42:40.183091Z","end":"2026-02-25T01:42:40.359734Z","steps":["trace[1548753393] 'process raft request' (duration: 176.266013ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:40.793631Z","caller":"traceutil/trace.go:171","msg":"trace[2131095017] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"148.926169ms","start":"2026-02-25T01:42:40.644672Z","end":"2026-02-25T01:42:40.793598Z","steps":["trace[2131095017] 'process raft request' (duration: 148.627809ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:40.994313Z","caller":"traceutil/trace.go:171","msg":"trace[2133212265] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"113.356973ms","start":"2026-02-25T01:42:40.880926Z","end":"2026-02-25T01:42:40.994283Z","steps":["trace[2133212265] 'process raft request' (duration: 97.625896ms)","trace[2133212265] 'compare' (duration: 15.588593ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:42:42.020373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.929934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T01:42:42.02049Z","caller":"traceutil/trace.go:171","msg":"trace[1146447941] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:656; }","duration":"389.036888ms","start":"2026-02-25T01:42:41.631412Z","end":"2026-02-25T01:42:42.020449Z","steps":["trace[1146447941] 'range keys from in-memory index tree' (duration: 388.838212ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:42.020539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:41.631343Z","time spent":"389.185903ms","remote":"127.0.0.1:55850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-25T01:42:42.276178Z","caller":"traceutil/trace.go:171","msg":"trace[981915439] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"134.73887ms","start":"2026-02-25T01:42:42.141414Z","end":"2026-02-25T01:42:42.276153Z","steps":["trace[981915439] 'process raft request' (duration: 132.289213ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:43.286777Z","caller":"traceutil/trace.go:171","msg":"trace[2143979219] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"316.125895ms","start":"2026-02-25T01:42:42.970628Z","end":"2026-02-25T01:42:43.286754Z","steps":["trace[2143979219] 'process raft request' (duration: 315.933019ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:43.286903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:42:42.970606Z","time spent":"316.247209ms","remote":"127.0.0.1:55938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":712,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T01:42:43.286754Z","caller":"traceutil/trace.go:171","msg":"trace[1799729305] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:680; }","duration":"226.398238ms","start":"2026-02-25T01:42:43.060332Z","end":"2026-02-25T01:42:43.28673Z","steps":["trace[1799729305] 'read index received' (duration: 226.14015ms)","trace[1799729305] 'applied index is now lower than readState.Index' (duration: 254.148µs)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:42:43.28698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.626997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-25T01:42:43.287147Z","caller":"traceutil/trace.go:171","msg":"trace[1213645437] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:663; }","duration":"226.814012ms","start":"2026-02-25T01:42:43.060285Z","end":"2026-02-25T01:42:43.287099Z","steps":["trace[1213645437] 'agreement among raft nodes before linearized reading' (duration: 226.543754ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:43.287297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.467984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-66t2l\" ","response":"range_response_count:1 size:17670"} {"level":"info","ts":"2026-02-25T01:42:43.287359Z","caller":"traceutil/trace.go:171","msg":"trace[475184562] range","detail":"{range_begin:/registry/pods/kube-system/cilium-66t2l; range_end:; response_count:1; response_revision:663; }","duration":"148.609078ms","start":"2026-02-25T01:42:43.138735Z","end":"2026-02-25T01:42:43.287344Z","steps":["trace[475184562] 'agreement among raft nodes before linearized reading' (duration: 148.338689ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:44.504078Z","caller":"traceutil/trace.go:171","msg":"trace[1333919013] linearizableReadLoop","detail":"{readStateIndex:711; appliedIndex:710; }","duration":"149.375633ms","start":"2026-02-25T01:42:44.354664Z","end":"2026-02-25T01:42:44.504039Z","steps":["trace[1333919013] 'read index received' (duration: 145.882652ms)","trace[1333919013] 'applied index is now lower than readState.Index' (duration: 3.491711ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:42:44.504114Z","caller":"traceutil/trace.go:171","msg":"trace[2047669167] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"219.559782ms","start":"2026-02-25T01:42:44.284518Z","end":"2026-02-25T01:42:44.504077Z","steps":["trace[2047669167] 'process raft request' (duration: 216.064891ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:44.504328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.656302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-25T01:42:44.504405Z","caller":"traceutil/trace.go:171","msg":"trace[1408586454] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:692; }","duration":"149.740285ms","start":"2026-02-25T01:42:44.354646Z","end":"2026-02-25T01:42:44.504386Z","steps":["trace[1408586454] 'agreement among raft nodes before linearized reading' (duration: 149.524908ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:44.507097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.390805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-25T01:42:44.507183Z","caller":"traceutil/trace.go:171","msg":"trace[257947113] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:693; }","duration":"150.53289ms","start":"2026-02-25T01:42:44.356631Z","end":"2026-02-25T01:42:44.507164Z","steps":["trace[257947113] 'agreement among raft nodes before linearized reading' (duration: 150.294652ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:45.470609Z","caller":"traceutil/trace.go:171","msg":"trace[841964854] linearizableReadLoop","detail":"{readStateIndex:730; appliedIndex:728; }","duration":"123.959649ms","start":"2026-02-25T01:42:45.346623Z","end":"2026-02-25T01:42:45.470582Z","steps":["trace[841964854] 'read index received' (duration: 5.750682ms)","trace[841964854] 'applied index is now lower than readState.Index' (duration: 118.207977ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:42:45.470686Z","caller":"traceutil/trace.go:171","msg":"trace[1101950106] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"157.387945ms","start":"2026-02-25T01:42:45.31327Z","end":"2026-02-25T01:42:45.470658Z","steps":["trace[1101950106] 'process raft request' (duration: 149.187756ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:45.470981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.33875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-25T01:42:45.471044Z","caller":"traceutil/trace.go:171","msg":"trace[1428541349] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:711; }","duration":"124.451024ms","start":"2026-02-25T01:42:45.346579Z","end":"2026-02-25T01:42:45.47103Z","steps":["trace[1428541349] 'agreement among raft nodes before linearized reading' (duration: 124.157365ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:51.427461Z","caller":"traceutil/trace.go:171","msg":"trace[1926047647] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"161.865158ms","start":"2026-02-25T01:42:51.26557Z","end":"2026-02-25T01:42:51.427435Z","steps":["trace[1926047647] 'process raft request' (duration: 161.569418ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:51.700213Z","caller":"traceutil/trace.go:171","msg":"trace[2119431685] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"149.631561ms","start":"2026-02-25T01:42:51.550543Z","end":"2026-02-25T01:42:51.700174Z","steps":["trace[2119431685] 'process raft request' (duration: 149.273519ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:52.184719Z","caller":"traceutil/trace.go:171","msg":"trace[524481856] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"132.422307ms","start":"2026-02-25T01:42:52.052274Z","end":"2026-02-25T01:42:52.184697Z","steps":["trace[524481856] 'process raft request' (duration: 132.311534ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:52.514634Z","caller":"traceutil/trace.go:171","msg":"trace[2048692013] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"262.837971ms","start":"2026-02-25T01:42:52.251778Z","end":"2026-02-25T01:42:52.514616Z","steps":["trace[2048692013] 'process raft request' (duration: 262.750948ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:52.692942Z","caller":"traceutil/trace.go:171","msg":"trace[937772619] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:809; }","duration":"133.100127ms","start":"2026-02-25T01:42:52.55982Z","end":"2026-02-25T01:42:52.69292Z","steps":["trace[937772619] 'read index received' (duration: 100.391133ms)","trace[937772619] 'applied index is now lower than readState.Index' (duration: 32.708234ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:42:52.692977Z","caller":"traceutil/trace.go:171","msg":"trace[1295568078] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"239.48138ms","start":"2026-02-25T01:42:52.453461Z","end":"2026-02-25T01:42:52.692942Z","steps":["trace[1295568078] 'process raft request' (duration: 206.782737ms)","trace[1295568078] 'compare' (duration: 32.445565ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:42:52.693159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.332975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-25T01:42:52.693189Z","caller":"traceutil/trace.go:171","msg":"trace[951658163] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:789; }","duration":"133.375996ms","start":"2026-02-25T01:42:52.559806Z","end":"2026-02-25T01:42:52.693182Z","steps":["trace[951658163] 'agreement among raft nodes before linearized reading' (duration: 133.218921ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:52.693248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.87384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-25T01:42:52.693316Z","caller":"traceutil/trace.go:171","msg":"trace[1691319905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:789; }","duration":"132.980694ms","start":"2026-02-25T01:42:52.560315Z","end":"2026-02-25T01:42:52.693296Z","steps":["trace[1691319905] 'agreement among raft nodes before linearized reading' (duration: 132.810248ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:52.693249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.980723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-25T01:42:52.693381Z","caller":"traceutil/trace.go:171","msg":"trace[1746817961] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:789; }","duration":"133.161169ms","start":"2026-02-25T01:42:52.560202Z","end":"2026-02-25T01:42:52.693364Z","steps":["trace[1746817961] 'agreement among raft nodes before linearized reading' (duration: 132.87125ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:53.337972Z","caller":"traceutil/trace.go:171","msg":"trace[1826568081] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"285.359193ms","start":"2026-02-25T01:42:53.052582Z","end":"2026-02-25T01:42:53.337942Z","steps":["trace[1826568081] 'process raft request' (duration: 239.810613ms)","trace[1826568081] 'compare' (duration: 45.257451ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:42:54.819878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.272972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T01:42:54.820089Z","caller":"traceutil/trace.go:171","msg":"trace[278051262] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:812; }","duration":"187.484048ms","start":"2026-02-25T01:42:54.632527Z","end":"2026-02-25T01:42:54.820011Z","steps":["trace[278051262] 'range keys from in-memory index tree' (duration: 187.191949ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:55.385802Z","caller":"traceutil/trace.go:171","msg":"trace[425329375] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"168.93362ms","start":"2026-02-25T01:42:55.216848Z","end":"2026-02-25T01:42:55.385782Z","steps":["trace[425329375] 'process raft request' (duration: 168.812476ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:57.033468Z","caller":"traceutil/trace.go:171","msg":"trace[1231175464] linearizableReadLoop","detail":"{readStateIndex:868; appliedIndex:867; }","duration":"183.182091ms","start":"2026-02-25T01:42:56.850271Z","end":"2026-02-25T01:42:57.033453Z","steps":["trace[1231175464] 'read index received' (duration: 182.992515ms)","trace[1231175464] 'applied index is now lower than readState.Index' (duration: 188.666µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:42:57.03356Z","caller":"traceutil/trace.go:171","msg":"trace[1377865691] transaction","detail":"{read_only:false; response_revision:845; number_of_response:1; }","duration":"191.968529ms","start":"2026-02-25T01:42:56.841559Z","end":"2026-02-25T01:42:57.033528Z","steps":["trace[1377865691] 'process raft request' (duration: 191.780713ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:57.033664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.388598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-25T01:42:57.033695Z","caller":"traceutil/trace.go:171","msg":"trace[1093726810] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:845; }","duration":"183.45695ms","start":"2026-02-25T01:42:56.850229Z","end":"2026-02-25T01:42:57.033686Z","steps":["trace[1093726810] 'agreement among raft nodes before linearized reading' (duration: 183.311036ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:57.033682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.13273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-25T01:42:57.033731Z","caller":"traceutil/trace.go:171","msg":"trace[1926909816] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:845; }","duration":"183.199102ms","start":"2026-02-25T01:42:56.850517Z","end":"2026-02-25T01:42:57.033716Z","steps":["trace[1926909816] 'agreement among raft nodes before linearized reading' (duration: 183.054948ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:42:57.033748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.338487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T01:42:57.033877Z","caller":"traceutil/trace.go:171","msg":"trace[2092153355] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:845; }","duration":"177.512162ms","start":"2026-02-25T01:42:56.856344Z","end":"2026-02-25T01:42:57.033856Z","steps":["trace[2092153355] 'agreement among raft nodes before linearized reading' (duration: 177.290655ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:57.196896Z","caller":"traceutil/trace.go:171","msg":"trace[1966109611] transaction","detail":"{read_only:false; response_revision:846; number_of_response:1; }","duration":"158.311426ms","start":"2026-02-25T01:42:57.038568Z","end":"2026-02-25T01:42:57.196879Z","steps":["trace[1966109611] 'process raft request' (duration: 158.172611ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:57.214228Z","caller":"traceutil/trace.go:171","msg":"trace[1388900172] transaction","detail":"{read_only:false; response_revision:847; number_of_response:1; }","duration":"175.021414ms","start":"2026-02-25T01:42:57.039182Z","end":"2026-02-25T01:42:57.214203Z","steps":["trace[1388900172] 'process raft request' (duration: 174.88591ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:58.669107Z","caller":"traceutil/trace.go:171","msg":"trace[1387568512] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"103.366078ms","start":"2026-02-25T01:42:58.565718Z","end":"2026-02-25T01:42:58.669084Z","steps":["trace[1387568512] 'process raft request' (duration: 102.405018ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:42:58.669492Z","caller":"traceutil/trace.go:171","msg":"trace[1278282794] transaction","detail":"{read_only:false; response_revision:857; number_of_response:1; }","duration":"101.965874ms","start":"2026-02-25T01:42:58.567515Z","end":"2026-02-25T01:42:58.669481Z","steps":["trace[1278282794] 'process raft request' (duration: 101.84615ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:43:03.211763Z","caller":"traceutil/trace.go:171","msg":"trace[2070600716] linearizableReadLoop","detail":"{readStateIndex:908; appliedIndex:907; }","duration":"130.495123ms","start":"2026-02-25T01:43:03.081247Z","end":"2026-02-25T01:43:03.211742Z","steps":["trace[2070600716] 'read index received' (duration: 130.359919ms)","trace[2070600716] 'applied index is now lower than readState.Index' (duration: 134.254µs)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:43:03.211879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.621057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-25T01:43:03.211905Z","caller":"traceutil/trace.go:171","msg":"trace[659649415] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:883; }","duration":"130.689139ms","start":"2026-02-25T01:43:03.081207Z","end":"2026-02-25T01:43:03.211896Z","steps":["trace[659649415] 'agreement among raft nodes before linearized reading' (duration: 130.620037ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:43:03.211882Z","caller":"traceutil/trace.go:171","msg":"trace[2120106056] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"151.866906ms","start":"2026-02-25T01:43:03.059976Z","end":"2026-02-25T01:43:03.211843Z","steps":["trace[2120106056] 'process raft request' (duration: 151.630698ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:43:03.429321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.825102ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T01:43:03.429431Z","caller":"traceutil/trace.go:171","msg":"trace[282549051] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"193.117315ms","start":"2026-02-25T01:43:03.236294Z","end":"2026-02-25T01:43:03.429411Z","steps":["trace[282549051] 'process raft request' (duration: 68.113788ms)","trace[282549051] 'compare' (duration: 124.685887ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:43:03.517249Z","caller":"traceutil/trace.go:171","msg":"trace[1544791271] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"279.392939ms","start":"2026-02-25T01:43:03.237833Z","end":"2026-02-25T01:43:03.517226Z","steps":["trace[1544791271] 'process raft request' (duration: 279.268996ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:43:03.871085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.405781ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-25T01:43:04.011529Z","caller":"traceutil/trace.go:171","msg":"trace[712245111] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"136.301398ms","start":"2026-02-25T01:43:03.875191Z","end":"2026-02-25T01:43:04.011492Z","steps":["trace[712245111] 'process raft request' (duration: 72.395426ms)","trace[712245111] 'compare' (duration: 63.762958ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:43:04.336727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.532508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/kube-system/coredns-5dd5756b68-pdxbh\" ","response":"range_response_count:1 size:2274"} {"level":"info","ts":"2026-02-25T01:43:04.336825Z","caller":"traceutil/trace.go:171","msg":"trace[301651712] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/kube-system/coredns-5dd5756b68-pdxbh; range_end:; response_count:1; response_revision:887; }","duration":"182.694913ms","start":"2026-02-25T01:43:04.154101Z","end":"2026-02-25T01:43:04.336796Z","steps":["trace[301651712] 'range keys from in-memory index tree' (duration: 182.330682ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:43:04.459111Z","caller":"traceutil/trace.go:171","msg":"trace[1549049468] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"112.309836ms","start":"2026-02-25T01:43:04.346732Z","end":"2026-02-25T01:43:04.459042Z","steps":["trace[1549049468] 'process raft request' (duration: 110.167592ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:43:04.578437Z","caller":"traceutil/trace.go:171","msg":"trace[1550657918] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"113.373438ms","start":"2026-02-25T01:43:04.465035Z","end":"2026-02-25T01:43:04.578409Z","steps":["trace[1550657918] 'process raft request' (duration: 112.955426ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:43:08.091917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.261939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-25T01:43:08.091977Z","caller":"traceutil/trace.go:171","msg":"trace[2029175871] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:923; }","duration":"174.375622ms","start":"2026-02-25T01:43:07.917584Z","end":"2026-02-25T01:43:08.091959Z","steps":["trace[2029175871] 'range keys from in-memory index tree' (duration: 174.123995ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:43:13.570846Z","caller":"traceutil/trace.go:171","msg":"trace[1305478254] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"225.596243ms","start":"2026-02-25T01:43:13.345202Z","end":"2026-02-25T01:43:13.570798Z","steps":["trace[1305478254] 'process raft request' (duration: 225.294724ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:43:14.047339Z","caller":"traceutil/trace.go:171","msg":"trace[1003305767] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"471.97173ms","start":"2026-02-25T01:43:13.575329Z","end":"2026-02-25T01:43:14.0473Z","steps":["trace[1003305767] 'process raft request' (duration: 374.144019ms)","trace[1003305767] 'compare' (duration: 97.493981ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:43:14.047538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:43:13.575321Z","time spent":"472.104924ms","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:43:14.049732Z","caller":"traceutil/trace.go:171","msg":"trace[1422689143] linearizableReadLoop","detail":"{readStateIndex:973; appliedIndex:971; }","duration":"453.229926ms","start":"2026-02-25T01:43:13.596479Z","end":"2026-02-25T01:43:14.049709Z","steps":["trace[1422689143] 'read index received' (duration: 352.988533ms)","trace[1422689143] 'applied index is now lower than readState.Index' (duration: 100.240193ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:43:14.049911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.413762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-02-25T01:43:14.049943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.563554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T01:43:14.050007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.480339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-02-25T01:43:14.049995Z","caller":"traceutil/trace.go:171","msg":"trace[614641372] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:945; }","duration":"453.523715ms","start":"2026-02-25T01:43:13.596442Z","end":"2026-02-25T01:43:14.049965Z","steps":["trace[614641372] 'agreement among raft nodes before linearized reading' (duration: 453.36514ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:43:14.050031Z","caller":"traceutil/trace.go:171","msg":"trace[486824344] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:945; }","duration":"376.528581ms","start":"2026-02-25T01:43:13.673495Z","end":"2026-02-25T01:43:14.050023Z","steps":["trace[486824344] 'agreement among raft nodes before linearized reading' (duration: 376.434518ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:43:14.05005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:43:13.673484Z","time spent":"376.561691ms","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-02-25T01:43:14.05005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:43:13.596429Z","time spent":"453.606118ms","remote":"127.0.0.1:55964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":6,"response size":29,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"info","ts":"2026-02-25T01:43:14.050036Z","caller":"traceutil/trace.go:171","msg":"trace[1191817512] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:945; }","duration":"417.658027ms","start":"2026-02-25T01:43:13.632363Z","end":"2026-02-25T01:43:14.050021Z","steps":["trace[1191817512] 'agreement among raft nodes before linearized reading' (duration: 417.539023ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:43:14.050143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:43:13.632329Z","time spent":"417.800121ms","remote":"127.0.0.1:55850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-25T01:43:15.460805Z","caller":"traceutil/trace.go:171","msg":"trace[1060917157] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"129.812373ms","start":"2026-02-25T01:43:15.330964Z","end":"2026-02-25T01:43:15.460776Z","steps":["trace[1060917157] 'process raft request' (duration: 129.664548ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:43:28.334144Z","caller":"traceutil/trace.go:171","msg":"trace[1108845306] linearizableReadLoop","detail":"{readStateIndex:1098; appliedIndex:1097; }","duration":"142.789523ms","start":"2026-02-25T01:43:28.191334Z","end":"2026-02-25T01:43:28.334124Z","steps":["trace[1108845306] 'read index received' (duration: 142.69953ms)","trace[1108845306] 'applied index is now lower than readState.Index' (duration: 89.163µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:43:28.334272Z","caller":"traceutil/trace.go:171","msg":"trace[747661671] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"221.998034ms","start":"2026-02-25T01:43:28.112232Z","end":"2026-02-25T01:43:28.33423Z","steps":["trace[747661671] 'process raft request' (duration: 221.771297ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:43:28.334553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.535755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-02-25T01:43:28.334626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.276678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-25T01:43:28.334723Z","caller":"traceutil/trace.go:171","msg":"trace[408398587] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1064; }","duration":"143.461083ms","start":"2026-02-25T01:43:28.191244Z","end":"2026-02-25T01:43:28.334705Z","steps":["trace[408398587] 'agreement among raft nodes before linearized reading' (duration: 143.02735ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:43:28.334646Z","caller":"traceutil/trace.go:171","msg":"trace[1426317919] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1064; }","duration":"142.66876ms","start":"2026-02-25T01:43:28.191953Z","end":"2026-02-25T01:43:28.334621Z","steps":["trace[1426317919] 'agreement among raft nodes before linearized reading' (duration: 142.34317ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:43:36.599768Z","caller":"traceutil/trace.go:171","msg":"trace[1847180966] linearizableReadLoop","detail":"{readStateIndex:1226; appliedIndex:1225; }","duration":"152.477825ms","start":"2026-02-25T01:43:36.447266Z","end":"2026-02-25T01:43:36.599744Z","steps":["trace[1847180966] 'read index received' (duration: 73.012846ms)","trace[1847180966] 'applied index is now lower than readState.Index' (duration: 79.464109ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:43:36.599792Z","caller":"traceutil/trace.go:171","msg":"trace[77050767] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"178.793266ms","start":"2026-02-25T01:43:36.420954Z","end":"2026-02-25T01:43:36.599747Z","steps":["trace[77050767] 'process raft request' (duration: 99.312486ms)","trace[77050767] 'compare' (duration: 79.053507ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:43:36.600409Z","caller":"traceutil/trace.go:171","msg":"trace[2064244839] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"148.809004ms","start":"2026-02-25T01:43:36.45156Z","end":"2026-02-25T01:43:36.600369Z","steps":["trace[2064244839] 'process raft request' (duration: 148.129753ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:43:36.600603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.681633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-25T01:43:36.600662Z","caller":"traceutil/trace.go:171","msg":"trace[1120594260] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1191; }","duration":"183.818777ms","start":"2026-02-25T01:43:36.416831Z","end":"2026-02-25T01:43:36.600649Z","steps":["trace[1120594260] 'agreement among raft nodes before linearized reading' (duration: 183.027033ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:43:36.758134Z","caller":"traceutil/trace.go:171","msg":"trace[1685754151] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"111.277176ms","start":"2026-02-25T01:43:36.646823Z","end":"2026-02-25T01:43:36.7581Z","steps":["trace[1685754151] 'process raft request' (duration: 88.46085ms)","trace[1685754151] 'compare' (duration: 22.709143ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:44:10.726619Z","caller":"traceutil/trace.go:171","msg":"trace[353745192] transaction","detail":"{read_only:false; response_revision:1550; number_of_response:1; }","duration":"126.417363ms","start":"2026-02-25T01:44:10.600177Z","end":"2026-02-25T01:44:10.726594Z","steps":["trace[353745192] 'process raft request' (duration: 126.259128ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:44:11.13152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.400663ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T01:44:11.131626Z","caller":"traceutil/trace.go:171","msg":"trace[1842255259] transaction","detail":"{read_only:false; response_revision:1551; number_of_response:1; }","duration":"350.794626ms","start":"2026-02-25T01:44:10.780812Z","end":"2026-02-25T01:44:11.131607Z","steps":["trace[1842255259] 'process raft request' (duration: 183.219629ms)","trace[1842255259] 'compare' (duration: 167.268948ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:44:11.131699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:44:10.780796Z","time spent":"350.867199ms","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:44:11.137907Z","caller":"traceutil/trace.go:171","msg":"trace[590707901] transaction","detail":"{read_only:false; response_revision:1552; number_of_response:1; }","duration":"355.749429ms","start":"2026-02-25T01:44:10.782133Z","end":"2026-02-25T01:44:11.137882Z","steps":["trace[590707901] 'process raft request' (duration: 355.549283ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:44:11.138105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:44:10.782113Z","time spent":"355.914154ms","remote":"127.0.0.1:56120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:44:11.13825Z","caller":"traceutil/trace.go:171","msg":"trace[937519904] transaction","detail":"{read_only:false; response_revision:1553; number_of_response:1; }","duration":"216.823771ms","start":"2026-02-25T01:44:10.921365Z","end":"2026-02-25T01:44:11.138189Z","steps":["trace[937519904] 'process raft request' (duration: 216.46853ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:44:11.697436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.257679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-25T01:44:11.697537Z","caller":"traceutil/trace.go:171","msg":"trace[517899879] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1553; }","duration":"140.424314ms","start":"2026-02-25T01:44:11.557087Z","end":"2026-02-25T01:44:11.697511Z","steps":["trace[517899879] 'count revisions from in-memory index tree' (duration: 140.152365ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:51:55.415224Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2119} {"level":"info","ts":"2026-02-25T01:51:55.465295Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2119,"took":"49.336294ms","hash":1789458528,"current-db-size-bytes":14462976,"current-db-size":"14 MB","current-db-size-in-use-bytes":4288512,"current-db-size-in-use":"4.3 MB"} {"level":"info","ts":"2026-02-25T01:51:55.46536Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1789458528,"revision":2119,"compact-revision":-1} {"level":"info","ts":"2026-02-25T01:56:55.420775Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3052} {"level":"info","ts":"2026-02-25T01:56:55.440318Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3052,"took":"18.832085ms","hash":3866415296,"current-db-size-bytes":14462976,"current-db-size":"14 MB","current-db-size-in-use-bytes":4681728,"current-db-size-in-use":"4.7 MB"} {"level":"info","ts":"2026-02-25T01:56:55.440387Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3866415296,"revision":3052,"compact-revision":2119}