{"level":"warn","ts":"2026-04-02T21:23:49.872583Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-02T21:23:49.872699Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.207: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.19.213.207:2380","--initial-cluster=instance=https://199.19.213.207:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.207:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.207: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-04-02T21:23:49.872807Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-02T21:23:49.872823Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.207:2380"]} {"level":"info","ts":"2026-04-02T21:23:49.872854Z","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-04-02T21:23:49.873745Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.207:2379"]} {"level":"info","ts":"2026-04-02T21:23:49.873868Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.207:2380"],"listen-peer-urls":["https://199.19.213.207:2380"],"advertise-client-urls":["https://199.19.213.207:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.207:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.207: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-04-02T21:23:49.881583Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.427992ms"} {"level":"info","ts":"2026-04-02T21:23:49.902851Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"520ed656383c33a4","cluster-id":"21f34f1629612ac4"} {"level":"info","ts":"2026-04-02T21:23:49.902982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 switched to configuration voters=()"} {"level":"info","ts":"2026-04-02T21:23:49.903008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 became follower at term 0"} {"level":"info","ts":"2026-04-02T21:23:49.903024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 520ed656383c33a4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-02T21:23:49.903034Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 became follower at term 1"} {"level":"info","ts":"2026-04-02T21:23:49.903081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 switched to configuration voters=(5912899026583040932)"} {"level":"warn","ts":"2026-04-02T21:23:49.921137Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-02T21:23:49.923619Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-02T21:23:49.925464Z","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-04-02T21:23:49.928417Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"520ed656383c33a4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-02T21:23:49.928655Z","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-04-02T21:23:49.928758Z","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-04-02T21:23:49.928777Z","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-04-02T21:23:49.928816Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"520ed656383c33a4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-02T21:23:49.933533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 switched to configuration voters=(5912899026583040932)"} {"level":"info","ts":"2026-04-02T21:23:49.933651Z","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-04-02T21:23:49.93386Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"21f34f1629612ac4","local-member-id":"520ed656383c33a4","added-peer-id":"520ed656383c33a4","added-peer-peer-urls":["https://199.19.213.207:2380"]} {"level":"info","ts":"2026-04-02T21:23:49.934351Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"520ed656383c33a4","initial-advertise-peer-urls":["https://199.19.213.207:2380"],"listen-peer-urls":["https://199.19.213.207:2380"],"advertise-client-urls":["https://199.19.213.207:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.207:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-02T21:23:49.938692Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.207:2380"} {"level":"info","ts":"2026-04-02T21:23:49.938748Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.207:2380"} {"level":"info","ts":"2026-04-02T21:23:49.939083Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-02T21:23:50.704473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 is starting a new election at term 1"} {"level":"info","ts":"2026-04-02T21:23:50.704526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-02T21:23:50.704563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 received MsgPreVoteResp from 520ed656383c33a4 at term 1"} {"level":"info","ts":"2026-04-02T21:23:50.704578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 became candidate at term 2"} {"level":"info","ts":"2026-04-02T21:23:50.704585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 received MsgVoteResp from 520ed656383c33a4 at term 2"} {"level":"info","ts":"2026-04-02T21:23:50.704598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"520ed656383c33a4 became leader at term 2"} {"level":"info","ts":"2026-04-02T21:23:50.704609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 520ed656383c33a4 elected leader 520ed656383c33a4 at term 2"} {"level":"info","ts":"2026-04-02T21:23:50.706443Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T21:23:50.716062Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"520ed656383c33a4","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.207:2379]}","request-path":"/0/members/520ed656383c33a4/attributes","cluster-id":"21f34f1629612ac4","publish-timeout":"7s"} {"level":"info","ts":"2026-04-02T21:23:50.716159Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T21:23:50.716224Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T21:23:50.716353Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-02T21:23:50.716413Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-02T21:23:50.720207Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.207:2379"} {"level":"info","ts":"2026-04-02T21:23:50.720399Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-02T21:23:50.724141Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"21f34f1629612ac4","local-member-id":"520ed656383c33a4","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T21:23:50.724471Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T21:23:50.724616Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T21:24:14.172384Z","caller":"traceutil/trace.go:171","msg":"trace[915643901] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"258.958307ms","start":"2026-04-02T21:24:13.9134Z","end":"2026-04-02T21:24:14.172358Z","steps":["trace[915643901] 'process raft request' (duration: 177.381516ms)","trace[915643901] 'compare' (duration: 81.429938ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T21:24:14.434413Z","caller":"traceutil/trace.go:171","msg":"trace[386785590] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"179.791637ms","start":"2026-04-02T21:24:14.254595Z","end":"2026-04-02T21:24:14.434387Z","steps":["trace[386785590] 'process raft request' (duration: 147.690941ms)","trace[386785590] 'compare' (duration: 31.976483ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T21:24:14.462978Z","caller":"traceutil/trace.go:171","msg":"trace[113333273] linearizableReadLoop","detail":"{readStateIndex:485; appliedIndex:483; }","duration":"143.151252ms","start":"2026-04-02T21:24:14.3198Z","end":"2026-04-02T21:24:14.462951Z","steps":["trace[113333273] 'read index received' (duration: 82.437408ms)","trace[113333273] 'applied index is now lower than readState.Index' (duration: 60.712394ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T21:24:14.463138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.319185ms","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-04-02T21:24:14.463249Z","caller":"traceutil/trace.go:171","msg":"trace[961927202] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:467; }","duration":"143.453417ms","start":"2026-04-02T21:24:14.319783Z","end":"2026-04-02T21:24:14.463236Z","steps":["trace[961927202] 'agreement among raft nodes before linearized reading' (duration: 143.267504ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:14.463322Z","caller":"traceutil/trace.go:171","msg":"trace[813244575] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"208.138699ms","start":"2026-04-02T21:24:14.255119Z","end":"2026-04-02T21:24:14.463258Z","steps":["trace[813244575] 'process raft request' (duration: 207.70452ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:20.43213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.037147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T21:24:20.43225Z","caller":"traceutil/trace.go:171","msg":"trace[1569359894] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:511; }","duration":"282.215261ms","start":"2026-04-02T21:24:20.150008Z","end":"2026-04-02T21:24:20.432223Z","steps":["trace[1569359894] 'range keys from in-memory index tree' (duration: 281.918845ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:21.067044Z","caller":"traceutil/trace.go:171","msg":"trace[1965749801] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"147.790487ms","start":"2026-04-02T21:24:20.919231Z","end":"2026-04-02T21:24:21.067022Z","steps":["trace[1965749801] 'process raft request' (duration: 140.201068ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:21.068313Z","caller":"traceutil/trace.go:171","msg":"trace[699899406] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"145.085498ms","start":"2026-04-02T21:24:20.923213Z","end":"2026-04-02T21:24:21.068299Z","steps":["trace[699899406] 'process raft request' (duration: 144.978086ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:21.06866Z","caller":"traceutil/trace.go:171","msg":"trace[1807714105] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"145.096788ms","start":"2026-04-02T21:24:20.92353Z","end":"2026-04-02T21:24:21.068627Z","steps":["trace[1807714105] 'process raft request' (duration: 144.735381ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:21.068704Z","caller":"traceutil/trace.go:171","msg":"trace[1572753809] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"131.790382ms","start":"2026-04-02T21:24:20.936889Z","end":"2026-04-02T21:24:21.068679Z","steps":["trace[1572753809] 'process raft request' (duration: 131.739071ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:21.068774Z","caller":"traceutil/trace.go:171","msg":"trace[1375094152] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"140.760087ms","start":"2026-04-02T21:24:20.928007Z","end":"2026-04-02T21:24:21.068768Z","steps":["trace[1375094152] 'process raft request' (duration: 140.556443ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:22.863448Z","caller":"traceutil/trace.go:171","msg":"trace[1109080359] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"368.568405ms","start":"2026-04-02T21:24:22.49486Z","end":"2026-04-02T21:24:22.863428Z","steps":["trace[1109080359] 'process raft request' (duration: 368.447583ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:22.863603Z","caller":"traceutil/trace.go:171","msg":"trace[1960341525] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:626; }","duration":"367.987335ms","start":"2026-04-02T21:24:22.495541Z","end":"2026-04-02T21:24:22.863528Z","steps":["trace[1960341525] 'read index received' (duration: 367.978615ms)","trace[1960341525] 'applied index is now lower than readState.Index' (duration: 7.09µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T21:24:22.86395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.384272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570105"} {"level":"info","ts":"2026-04-02T21:24:22.864013Z","caller":"traceutil/trace.go:171","msg":"trace[1044477625] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:603; }","duration":"368.477893ms","start":"2026-04-02T21:24:22.495515Z","end":"2026-04-02T21:24:22.863993Z","steps":["trace[1044477625] 'agreement among raft nodes before linearized reading' (duration: 368.151467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:22.864043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:22.495506Z","time spent":"368.531724ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":570127,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-04-02T21:24:22.864022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:22.494838Z","time spent":"368.681777ms","remote":"127.0.0.1:52074","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-04-02T21:24:22.913165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.506459ms","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-04-02T21:24:22.913254Z","caller":"traceutil/trace.go:171","msg":"trace[400147128] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:607; }","duration":"408.634091ms","start":"2026-04-02T21:24:22.504602Z","end":"2026-04-02T21:24:22.913236Z","steps":["trace[400147128] 'agreement among raft nodes before linearized reading' (duration: 408.471688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:22.913294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:22.504593Z","time spent":"408.692613ms","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-02T21:24:22.9188Z","caller":"traceutil/trace.go:171","msg":"trace[1154108879] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"389.204489ms","start":"2026-04-02T21:24:22.529546Z","end":"2026-04-02T21:24:22.918751Z","steps":["trace[1154108879] 'process raft request' (duration: 383.270841ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:22.918855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.648516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-02T21:24:22.918856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.305282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-x25wb\" ","response":"range_response_count:1 size:4683"} {"level":"warn","ts":"2026-04-02T21:24:22.918956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:22.529503Z","time spent":"389.383223ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208470,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T21:24:22.918964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.903653ms","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-04-02T21:24:22.918982Z","caller":"traceutil/trace.go:171","msg":"trace[1580037702] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-x25wb; range_end:; response_count:1; response_revision:607; }","duration":"163.493545ms","start":"2026-04-02T21:24:22.755448Z","end":"2026-04-02T21:24:22.918942Z","steps":["trace[1580037702] 'agreement among raft nodes before linearized reading' (duration: 163.23159ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:22.918999Z","caller":"traceutil/trace.go:171","msg":"trace[1211146256] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:607; }","duration":"270.964395ms","start":"2026-04-02T21:24:22.648026Z","end":"2026-04-02T21:24:22.918991Z","steps":["trace[1211146256] 'agreement among raft nodes before linearized reading' (duration: 270.902584ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:22.919129Z","caller":"traceutil/trace.go:171","msg":"trace[643039926] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"417.986131ms","start":"2026-04-02T21:24:22.501123Z","end":"2026-04-02T21:24:22.919109Z","steps":["trace[643039926] 'process raft request' (duration: 411.465762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:22.919188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:22.501109Z","time spent":"418.041473ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10353,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T21:24:22.919312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.817318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T21:24:22.919305Z","caller":"traceutil/trace.go:171","msg":"trace[1307742070] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"262.518821ms","start":"2026-04-02T21:24:22.656772Z","end":"2026-04-02T21:24:22.91929Z","steps":["trace[1307742070] 'process raft request' (duration: 256.230507ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:22.919367Z","caller":"traceutil/trace.go:171","msg":"trace[10159066] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:607; }","duration":"342.892199ms","start":"2026-04-02T21:24:22.576464Z","end":"2026-04-02T21:24:22.919357Z","steps":["trace[10159066] 'agreement among raft nodes before linearized reading' (duration: 342.236207ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:22.919393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:22.576448Z","time spent":"342.93774ms","remote":"127.0.0.1:51814","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-04-02T21:24:22.918897Z","caller":"traceutil/trace.go:171","msg":"trace[1852834340] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:607; }","duration":"175.744818ms","start":"2026-04-02T21:24:22.743138Z","end":"2026-04-02T21:24:22.918883Z","steps":["trace[1852834340] 'agreement among raft nodes before linearized reading' (duration: 175.619865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:23.472302Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721272159385818092,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T21:24:23.753778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:23.236289Z","time spent":"517.479933ms","remote":"127.0.0.1:36120","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-02T21:24:23.7543Z","caller":"traceutil/trace.go:171","msg":"trace[1878076738] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"828.373584ms","start":"2026-04-02T21:24:22.925892Z","end":"2026-04-02T21:24:23.754265Z","steps":["trace[1878076738] 'process raft request' (duration: 818.567358ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:23.754342Z","caller":"traceutil/trace.go:171","msg":"trace[448512641] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"808.117007ms","start":"2026-04-02T21:24:22.946195Z","end":"2026-04-02T21:24:23.754312Z","steps":["trace[448512641] 'process raft request' (duration: 808.071006ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:23.754477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:22.925852Z","time spent":"828.532567ms","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T21:24:23.754511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:22.946174Z","time spent":"808.243289ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5571,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T21:24:23.754517Z","caller":"traceutil/trace.go:171","msg":"trace[1872316471] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"825.39969ms","start":"2026-04-02T21:24:22.929081Z","end":"2026-04-02T21:24:23.754481Z","steps":["trace[1872316471] 'process raft request' (duration: 825.102485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:23.754754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:22.929073Z","time spent":"825.570924ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4156,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T21:24:23.754909Z","caller":"traceutil/trace.go:171","msg":"trace[1944889152] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"821.334747ms","start":"2026-04-02T21:24:22.933565Z","end":"2026-04-02T21:24:23.7549Z","steps":["trace[1944889152] 'process raft request' (duration: 820.660724ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:23.754985Z","caller":"traceutil/trace.go:171","msg":"trace[1724912195] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"826.082663ms","start":"2026-04-02T21:24:22.928885Z","end":"2026-04-02T21:24:23.754968Z","steps":["trace[1724912195] 'process raft request' (duration: 825.256528ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:23.755139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:22.933541Z","time spent":"821.399368ms","remote":"127.0.0.1:52004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4873,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T21:24:23.755987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:22.928859Z","time spent":"826.170774ms","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T21:24:23.77457Z","caller":"traceutil/trace.go:171","msg":"trace[2063166221] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"794.531897ms","start":"2026-04-02T21:24:22.979972Z","end":"2026-04-02T21:24:23.774504Z","steps":["trace[2063166221] 'process raft request' (duration: 794.303833ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:23.774651Z","caller":"traceutil/trace.go:171","msg":"trace[1816347812] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:631; }","duration":"802.739986ms","start":"2026-04-02T21:24:22.971892Z","end":"2026-04-02T21:24:23.774632Z","steps":["trace[1816347812] 'read index received' (duration: 772.654045ms)","trace[1816347812] 'applied index is now lower than readState.Index' (duration: 30.084091ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T21:24:23.77467Z","caller":"traceutil/trace.go:171","msg":"trace[708703465] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"317.821684ms","start":"2026-04-02T21:24:23.45683Z","end":"2026-04-02T21:24:23.774652Z","steps":["trace[708703465] 'process raft request' (duration: 317.587919ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:23.774744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:22.979949Z","time spent":"794.697691ms","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T21:24:23.77474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:23.456811Z","time spent":"317.893845ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T21:24:23.774869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"802.96955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:15688"} {"level":"info","ts":"2026-04-02T21:24:23.774896Z","caller":"traceutil/trace.go:171","msg":"trace[486786775] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:615; }","duration":"803.002201ms","start":"2026-04-02T21:24:22.971886Z","end":"2026-04-02T21:24:23.774889Z","steps":["trace[486786775] 'agreement among raft nodes before linearized reading' (duration: 802.815858ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:23.774917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:22.971847Z","time spent":"803.064932ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":15710,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-04-02T21:24:23.786505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.095979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T21:24:23.786598Z","caller":"traceutil/trace.go:171","msg":"trace[2005143268] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:617; }","duration":"130.237222ms","start":"2026-04-02T21:24:23.656345Z","end":"2026-04-02T21:24:23.786582Z","steps":["trace[2005143268] 'agreement among raft nodes before linearized reading' (duration: 130.11296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:23.786558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.142882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T21:24:23.78689Z","caller":"traceutil/trace.go:171","msg":"trace[876227098] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:617; }","duration":"208.518949ms","start":"2026-04-02T21:24:23.578345Z","end":"2026-04-02T21:24:23.786864Z","steps":["trace[876227098] 'agreement among raft nodes before linearized reading' (duration: 208.131342ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:23.786793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.902283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T21:24:23.787399Z","caller":"traceutil/trace.go:171","msg":"trace[713025089] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:617; }","duration":"532.570814ms","start":"2026-04-02T21:24:23.254809Z","end":"2026-04-02T21:24:23.78738Z","steps":["trace[713025089] 'agreement among raft nodes before linearized reading' (duration: 531.922443ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:23.787552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:23.254788Z","time spent":"532.744898ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"warn","ts":"2026-04-02T21:24:23.788133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.381636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T21:24:23.788424Z","caller":"traceutil/trace.go:171","msg":"trace[1254016604] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:617; }","duration":"732.724733ms","start":"2026-04-02T21:24:23.055679Z","end":"2026-04-02T21:24:23.788404Z","steps":["trace[1254016604] 'agreement among raft nodes before linearized reading' (duration: 730.738697ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:23.789076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:23.055664Z","time spent":"733.397695ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"info","ts":"2026-04-02T21:24:24.081211Z","caller":"traceutil/trace.go:171","msg":"trace[1888926322] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"288.057386ms","start":"2026-04-02T21:24:23.793131Z","end":"2026-04-02T21:24:24.081188Z","steps":["trace[1888926322] 'process raft request' (duration: 287.912274ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:24.303379Z","caller":"traceutil/trace.go:171","msg":"trace[229090635] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:641; }","duration":"447.952897ms","start":"2026-04-02T21:24:23.855409Z","end":"2026-04-02T21:24:24.303362Z","steps":["trace[229090635] 'read index received' (duration: 225.876529ms)","trace[229090635] 'applied index is now lower than readState.Index' (duration: 222.075518ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T21:24:24.303456Z","caller":"traceutil/trace.go:171","msg":"trace[791537432] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"510.043062ms","start":"2026-04-02T21:24:23.793407Z","end":"2026-04-02T21:24:24.30345Z","steps":["trace[791537432] 'process raft request' (duration: 509.791678ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:24.303533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:23.793394Z","time spent":"510.085063ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4165,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T21:24:24.303671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.225741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T21:24:24.303755Z","caller":"traceutil/trace.go:171","msg":"trace[1697762783] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:620; }","duration":"448.363213ms","start":"2026-04-02T21:24:23.855379Z","end":"2026-04-02T21:24:24.303742Z","steps":["trace[1697762783] 'agreement among raft nodes before linearized reading' (duration: 448.14054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:24.303814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:23.855364Z","time spent":"448.443215ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"info","ts":"2026-04-02T21:24:24.303991Z","caller":"traceutil/trace.go:171","msg":"trace[885611891] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"510.219716ms","start":"2026-04-02T21:24:23.793754Z","end":"2026-04-02T21:24:24.303973Z","steps":["trace[885611891] 'process raft request' (duration: 509.570284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:24.304136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:23.793741Z","time spent":"510.320397ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9296,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T21:24:25.090912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.009532ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T21:24:25.091051Z","caller":"traceutil/trace.go:171","msg":"trace[772481669] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:643; }","duration":"787.590221ms","start":"2026-04-02T21:24:24.30343Z","end":"2026-04-02T21:24:25.09102Z","steps":["trace[772481669] 'read index received' (duration: 459.225013ms)","trace[772481669] 'applied index is now lower than readState.Index' (duration: 328.363898ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T21:24:25.091141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.164448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-04-02T21:24:25.091151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"836.501033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"warn","ts":"2026-04-02T21:24:25.091192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.220825213s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.207\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-02T21:24:25.09121Z","caller":"traceutil/trace.go:171","msg":"trace[800655127] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:621; }","duration":"836.589244ms","start":"2026-04-02T21:24:24.254606Z","end":"2026-04-02T21:24:25.091195Z","steps":["trace[800655127] 'agreement among raft nodes before linearized reading' (duration: 836.444312ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:25.091218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.036737312s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-04-02T21:24:25.091245Z","caller":"traceutil/trace.go:171","msg":"trace[9210728] range","detail":"{range_begin:/registry/masterleases/199.19.213.207; range_end:; response_count:1; response_revision:621; }","duration":"1.220904725s","start":"2026-04-02T21:24:23.870327Z","end":"2026-04-02T21:24:25.091232Z","steps":["trace[9210728] 'agreement among raft nodes before linearized reading' (duration: 1.220807583s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:25.091313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:23.870313Z","time spent":"1.220988286s","remote":"127.0.0.1:51864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.207\" "} {"level":"info","ts":"2026-04-02T21:24:25.091255Z","caller":"traceutil/trace.go:171","msg":"trace[1124177358] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:621; }","duration":"1.036801192s","start":"2026-04-02T21:24:24.054443Z","end":"2026-04-02T21:24:25.091244Z","steps":["trace[1124177358] 'agreement among raft nodes before linearized reading' (duration: 1.03666699s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:25.091253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:24.254589Z","time spent":"836.653185ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4202,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "} {"level":"warn","ts":"2026-04-02T21:24:25.092301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:24.054427Z","time spent":"1.037844851s","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":1,"response size":5608,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" "} {"level":"info","ts":"2026-04-02T21:24:25.092329Z","caller":"traceutil/trace.go:171","msg":"trace[1064930042] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"1.003284855s","start":"2026-04-02T21:24:24.089025Z","end":"2026-04-02T21:24:25.092309Z","steps":["trace[1064930042] 'process raft request' (duration: 673.641434ms)","trace[1064930042] 'compare' (duration: 327.817629ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T21:24:25.092398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:24.089002Z","time spent":"1.003359687s","remote":"127.0.0.1:52272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4387,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T21:24:25.091201Z","caller":"traceutil/trace.go:171","msg":"trace[1632793370] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:621; }","duration":"822.267189ms","start":"2026-04-02T21:24:24.26892Z","end":"2026-04-02T21:24:25.091188Z","steps":["trace[1632793370] 'agreement among raft nodes before linearized reading' (duration: 822.115647ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:25.092474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:24.268904Z","time spent":"823.549842ms","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-02T21:24:25.389629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.962767ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T21:24:25.389871Z","caller":"traceutil/trace.go:171","msg":"trace[1122102258] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"1.080906183s","start":"2026-04-02T21:24:24.308936Z","end":"2026-04-02T21:24:25.389842Z","steps":["trace[1122102258] 'process raft request' (duration: 899.63888ms)","trace[1122102258] 'compare' (duration: 180.859516ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T21:24:25.389964Z","caller":"traceutil/trace.go:171","msg":"trace[252882581] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"1.079521008s","start":"2026-04-02T21:24:24.310407Z","end":"2026-04-02T21:24:25.389928Z","steps":["trace[252882581] 'process raft request' (duration: 1.079329145s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:25.390004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.660913ms","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-04-02T21:24:25.39004Z","caller":"traceutil/trace.go:171","msg":"trace[60465984] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:623; }","duration":"368.707844ms","start":"2026-04-02T21:24:25.021322Z","end":"2026-04-02T21:24:25.39003Z","steps":["trace[60465984] 'agreement among raft nodes before linearized reading' (duration: 368.552181ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:25.390042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.679958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-02T21:24:25.390101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.854246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4074"} {"level":"warn","ts":"2026-04-02T21:24:25.390079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:24.308911Z","time spent":"1.081032545s","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4059,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T21:24:25.390105Z","caller":"traceutil/trace.go:171","msg":"trace[1995513680] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:623; }","duration":"521.768509ms","start":"2026-04-02T21:24:24.868317Z","end":"2026-04-02T21:24:25.390086Z","steps":["trace[1995513680] 'agreement among raft nodes before linearized reading' (duration: 521.592506ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:25.390126Z","caller":"traceutil/trace.go:171","msg":"trace[1364708876] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:623; }","duration":"334.908068ms","start":"2026-04-02T21:24:25.055211Z","end":"2026-04-02T21:24:25.390119Z","steps":["trace[1364708876] 'agreement among raft nodes before linearized reading' (duration: 334.870127ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:25.3901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:24.310389Z","time spent":"1.07963869s","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4318,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T21:24:25.390145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:25.055188Z","time spent":"334.953618ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4096,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "} {"level":"warn","ts":"2026-04-02T21:24:25.390155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:24.868285Z","time spent":"521.857631ms","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T21:24:25.390384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.396002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9311"} {"level":"warn","ts":"2026-04-02T21:24:25.390442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.918848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T21:24:25.390444Z","caller":"traceutil/trace.go:171","msg":"trace[619759965] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:623; }","duration":"535.482933ms","start":"2026-04-02T21:24:24.854944Z","end":"2026-04-02T21:24:25.390427Z","steps":["trace[619759965] 'agreement among raft nodes before linearized reading' (duration: 535.28681ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:25.390491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.365615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"} {"level":"info","ts":"2026-04-02T21:24:25.390489Z","caller":"traceutil/trace.go:171","msg":"trace[799500129] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway; range_end:; response_count:0; response_revision:623; }","duration":"509.989839ms","start":"2026-04-02T21:24:24.880482Z","end":"2026-04-02T21:24:25.390472Z","steps":["trace[799500129] 'agreement among raft nodes before linearized reading' (duration: 509.919778ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:25.390493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:24.854917Z","time spent":"535.563815ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":9333,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "} {"level":"info","ts":"2026-04-02T21:24:25.390518Z","caller":"traceutil/trace.go:171","msg":"trace[702532335] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:623; }","duration":"735.421027ms","start":"2026-04-02T21:24:24.65509Z","end":"2026-04-02T21:24:25.390511Z","steps":["trace[702532335] 'agreement among raft nodes before linearized reading' (duration: 735.376366ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:25.390563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:24.655074Z","time spent":"735.459667ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4355,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "} {"level":"warn","ts":"2026-04-02T21:24:25.390572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:24.880465Z","time spent":"510.071891ms","remote":"127.0.0.1:52026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" "} {"level":"warn","ts":"2026-04-02T21:24:25.390067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:25.021279Z","time spent":"368.782316ms","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-02T21:24:25.38987Z","caller":"traceutil/trace.go:171","msg":"trace[693783583] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:644; }","duration":"298.768459ms","start":"2026-04-02T21:24:25.091083Z","end":"2026-04-02T21:24:25.389852Z","steps":["trace[693783583] 'read index received' (duration: 117.504136ms)","trace[693783583] 'applied index is now lower than readState.Index' (duration: 181.263213ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T21:24:25.391791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"936.523979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-04-02T21:24:25.392348Z","caller":"traceutil/trace.go:171","msg":"trace[712455204] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:623; }","duration":"937.10653ms","start":"2026-04-02T21:24:24.455219Z","end":"2026-04-02T21:24:25.392326Z","steps":["trace[712455204] 'agreement among raft nodes before linearized reading' (duration: 936.500149ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:25.392425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:24.455198Z","time spent":"937.205181ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":10399,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"info","ts":"2026-04-02T21:24:25.405545Z","caller":"traceutil/trace.go:171","msg":"trace[1690348730] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"306.21335ms","start":"2026-04-02T21:24:25.099312Z","end":"2026-04-02T21:24:25.405525Z","steps":["trace[1690348730] 'process raft request' (duration: 306.157959ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:25.40568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:25.09929Z","time spent":"306.322741ms","remote":"127.0.0.1:52256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4694,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T21:24:25.405723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:25.093357Z","time spent":"312.363709ms","remote":"127.0.0.1:51864","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-02T21:24:25.405781Z","caller":"traceutil/trace.go:171","msg":"trace[121460257] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"309.60022ms","start":"2026-04-02T21:24:25.096155Z","end":"2026-04-02T21:24:25.405755Z","steps":["trace[121460257] 'process raft request' (duration: 309.226693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:25.405896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:25.096133Z","time spent":"309.699571ms","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T21:24:25.443807Z","caller":"traceutil/trace.go:171","msg":"trace[401740696] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"184.650173ms","start":"2026-04-02T21:24:25.259124Z","end":"2026-04-02T21:24:25.443774Z","steps":["trace[401740696] 'process raft request' (duration: 184.398008ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:25.643203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.848142ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T21:24:25.643347Z","caller":"traceutil/trace.go:171","msg":"trace[1524011652] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"195.776889ms","start":"2026-04-02T21:24:25.447548Z","end":"2026-04-02T21:24:25.643325Z","steps":["trace[1524011652] 'read index received' (duration: 64.794145ms)","trace[1524011652] 'applied index is now lower than readState.Index' (duration: 130.980974ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T21:24:25.643384Z","caller":"traceutil/trace.go:171","msg":"trace[270238013] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"237.002378ms","start":"2026-04-02T21:24:25.406355Z","end":"2026-04-02T21:24:25.643357Z","steps":["trace[270238013] 'process raft request' (duration: 105.902472ms)","trace[270238013] 'compare' (duration: 130.697899ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T21:24:25.64358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.009353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/envoy-gateway-gateway-helm-envoy-gateway-role\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T21:24:25.643661Z","caller":"traceutil/trace.go:171","msg":"trace[574640661] range","detail":"{range_begin:/registry/clusterroles/envoy-gateway-gateway-helm-envoy-gateway-role; range_end:; response_count:0; response_revision:631; }","duration":"196.140695ms","start":"2026-04-02T21:24:25.447503Z","end":"2026-04-02T21:24:25.643643Z","steps":["trace[574640661] 'agreement among raft nodes before linearized reading' (duration: 195.950461ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:25.666343Z","caller":"traceutil/trace.go:171","msg":"trace[640960430] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"216.648037ms","start":"2026-04-02T21:24:25.449665Z","end":"2026-04-02T21:24:25.666313Z","steps":["trace[640960430] 'process raft request' (duration: 216.492484ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:25.666473Z","caller":"traceutil/trace.go:171","msg":"trace[358541088] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"181.603559ms","start":"2026-04-02T21:24:25.484857Z","end":"2026-04-02T21:24:25.666461Z","steps":["trace[358541088] 'process raft request' (duration: 181.476837ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:25.666393Z","caller":"traceutil/trace.go:171","msg":"trace[69315639] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"210.289605ms","start":"2026-04-02T21:24:25.456071Z","end":"2026-04-02T21:24:25.666361Z","steps":["trace[69315639] 'process raft request' (duration: 210.174553ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:33.124128Z","caller":"traceutil/trace.go:171","msg":"trace[761261481] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"324.318975ms","start":"2026-04-02T21:24:32.799773Z","end":"2026-04-02T21:24:33.124092Z","steps":["trace[761261481] 'process raft request' (duration: 324.095601ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:33.124344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:32.79974Z","time spent":"324.488787ms","remote":"127.0.0.1:52004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T21:24:34.316558Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3721272159385818343,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-02T21:24:34.592431Z","caller":"traceutil/trace.go:171","msg":"trace[150293459] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"1.100892286s","start":"2026-04-02T21:24:33.491515Z","end":"2026-04-02T21:24:34.592407Z","steps":["trace[150293459] 'process raft request' (duration: 1.020912906s)","trace[150293459] 'compare' (duration: 79.396731ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T21:24:34.592457Z","caller":"traceutil/trace.go:171","msg":"trace[1521539286] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"722.332242ms","start":"2026-04-02T21:24:33.870093Z","end":"2026-04-02T21:24:34.592425Z","steps":["trace[1521539286] 'process raft request' (duration: 721.863805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:34.59255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:33.491485Z","time spent":"1.101005708s","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T21:24:34.592635Z","caller":"traceutil/trace.go:171","msg":"trace[1921284217] linearizableReadLoop","detail":"{readStateIndex:720; appliedIndex:718; }","duration":"776.950305ms","start":"2026-04-02T21:24:33.815656Z","end":"2026-04-02T21:24:34.592606Z","steps":["trace[1921284217] 'read index received' (duration: 696.785882ms)","trace[1921284217] 'applied index is now lower than readState.Index' (duration: 80.161163ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T21:24:34.592825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.172089ms","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-04-02T21:24:34.592858Z","caller":"traceutil/trace.go:171","msg":"trace[1648189142] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:695; }","duration":"777.203959ms","start":"2026-04-02T21:24:33.815645Z","end":"2026-04-02T21:24:34.592849Z","steps":["trace[1648189142] 'agreement among raft nodes before linearized reading' (duration: 777.058667ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:34.592876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:33.815593Z","time spent":"777.278941ms","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-02T21:24:34.592839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:33.87007Z","time spent":"722.440715ms","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T21:24:34.592998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"775.752595ms","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-04-02T21:24:34.593051Z","caller":"traceutil/trace.go:171","msg":"trace[1472267337] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:695; }","duration":"775.878218ms","start":"2026-04-02T21:24:33.817161Z","end":"2026-04-02T21:24:34.593039Z","steps":["trace[1472267337] 'agreement among raft nodes before linearized reading' (duration: 775.665704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:34.593085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:33.817128Z","time spent":"775.948998ms","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-02T21:24:34.593212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.667608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.207\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-02T21:24:34.593302Z","caller":"traceutil/trace.go:171","msg":"trace[1698396399] range","detail":"{range_begin:/registry/masterleases/199.19.213.207; range_end:; response_count:1; response_revision:695; }","duration":"722.7964ms","start":"2026-04-02T21:24:33.870479Z","end":"2026-04-02T21:24:34.593276Z","steps":["trace[1698396399] 'agreement among raft nodes before linearized reading' (duration: 722.543346ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:34.593343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:33.870452Z","time spent":"722.880872ms","remote":"127.0.0.1:51864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.207\" "} {"level":"warn","ts":"2026-04-02T21:24:36.898139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.418882075s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-02T21:24:36.899674Z","caller":"traceutil/trace.go:171","msg":"trace[301287618] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:698; }","duration":"1.42042981s","start":"2026-04-02T21:24:35.479199Z","end":"2026-04-02T21:24:36.899629Z","steps":["trace[301287618] 'range keys from in-memory index tree' (duration: 1.418715572s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:36.900453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:35.479181Z","time spent":"1.421234673s","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-02T21:24:36.898981Z","caller":"traceutil/trace.go:171","msg":"trace[962720271] linearizableReadLoop","detail":"{readStateIndex:725; appliedIndex:724; }","duration":"319.627053ms","start":"2026-04-02T21:24:36.579331Z","end":"2026-04-02T21:24:36.898958Z","steps":["trace[962720271] 'read index received' (duration: 310.999184ms)","trace[962720271] 'applied index is now lower than readState.Index' (duration: 8.626519ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T21:24:36.899032Z","caller":"traceutil/trace.go:171","msg":"trace[1316451800] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"397.481999ms","start":"2026-04-02T21:24:36.501524Z","end":"2026-04-02T21:24:36.899006Z","steps":["trace[1316451800] 'process raft request' (duration: 388.87054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:36.900942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:36.50149Z","time spent":"399.375659ms","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T21:24:36.899089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.743355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T21:24:36.901049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.485804ms","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-04-02T21:24:36.901104Z","caller":"traceutil/trace.go:171","msg":"trace[1199185132] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:699; }","duration":"321.766968ms","start":"2026-04-02T21:24:36.579319Z","end":"2026-04-02T21:24:36.901086Z","steps":["trace[1199185132] 'agreement among raft nodes before linearized reading' (duration: 319.712745ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:36.901114Z","caller":"traceutil/trace.go:171","msg":"trace[466028549] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:699; }","duration":"303.587415ms","start":"2026-04-02T21:24:36.597507Z","end":"2026-04-02T21:24:36.901094Z","steps":["trace[466028549] 'agreement among raft nodes before linearized reading' (duration: 303.413542ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:36.901123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.625687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-02T21:24:36.899209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.314982176s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-02T21:24:36.90117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:36.597484Z","time spent":"303.668477ms","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-02T21:24:36.901189Z","caller":"traceutil/trace.go:171","msg":"trace[674018720] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:698; }","duration":"1.317012559s","start":"2026-04-02T21:24:35.584162Z","end":"2026-04-02T21:24:36.901174Z","steps":["trace[674018720] 'range keys from in-memory index tree' (duration: 1.314325256s)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:36.901191Z","caller":"traceutil/trace.go:171","msg":"trace[1498830356] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:699; }","duration":"269.722089ms","start":"2026-04-02T21:24:36.631452Z","end":"2026-04-02T21:24:36.901175Z","steps":["trace[1498830356] 'agreement among raft nodes before linearized reading' (duration: 269.538476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:36.901224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:35.584138Z","time spent":"1.31707585s","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T21:24:36.901149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:36.579261Z","time spent":"321.87639ms","remote":"127.0.0.1:51806","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-04-02T21:24:36.901289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.800801ms","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-04-02T21:24:36.901334Z","caller":"traceutil/trace.go:171","msg":"trace[1260356741] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:699; }","duration":"269.880832ms","start":"2026-04-02T21:24:36.631437Z","end":"2026-04-02T21:24:36.901318Z","steps":["trace[1260356741] 'agreement among raft nodes before linearized reading' (duration: 269.76704ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:43.140622Z","caller":"traceutil/trace.go:171","msg":"trace[1023927027] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"116.963456ms","start":"2026-04-02T21:24:43.023615Z","end":"2026-04-02T21:24:43.140579Z","steps":["trace[1023927027] 'process raft request' (duration: 116.901706ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:43.140942Z","caller":"traceutil/trace.go:171","msg":"trace[466656355] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"102.285062ms","start":"2026-04-02T21:24:43.038645Z","end":"2026-04-02T21:24:43.14093Z","steps":["trace[466656355] 'process raft request' (duration: 102.18399ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:43.141202Z","caller":"traceutil/trace.go:171","msg":"trace[1543902414] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"116.885824ms","start":"2026-04-02T21:24:43.024282Z","end":"2026-04-02T21:24:43.141168Z","steps":["trace[1543902414] 'process raft request' (duration: 116.263435ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:43.14067Z","caller":"traceutil/trace.go:171","msg":"trace[1926928276] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"117.079698ms","start":"2026-04-02T21:24:43.02352Z","end":"2026-04-02T21:24:43.140599Z","steps":["trace[1926928276] 'process raft request' (duration: 116.854774ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:53.36555Z","caller":"traceutil/trace.go:171","msg":"trace[1705580362] linearizableReadLoop","detail":"{readStateIndex:833; appliedIndex:832; }","duration":"204.85556ms","start":"2026-04-02T21:24:53.160675Z","end":"2026-04-02T21:24:53.36553Z","steps":["trace[1705580362] 'read index received' (duration: 204.651257ms)","trace[1705580362] 'applied index is now lower than readState.Index' (duration: 203.593µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T21:24:53.365627Z","caller":"traceutil/trace.go:171","msg":"trace[1837061823] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"287.080658ms","start":"2026-04-02T21:24:53.078518Z","end":"2026-04-02T21:24:53.365598Z","steps":["trace[1837061823] 'process raft request' (duration: 286.883285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:53.365851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.019111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-02T21:24:53.365886Z","caller":"traceutil/trace.go:171","msg":"trace[1951126645] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:803; }","duration":"162.103053ms","start":"2026-04-02T21:24:53.203775Z","end":"2026-04-02T21:24:53.365878Z","steps":["trace[1951126645] 'agreement among raft nodes before linearized reading' (duration: 161.990691ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:53.365895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.808255ms","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-04-02T21:24:53.365955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.694706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-02T21:24:53.366221Z","caller":"traceutil/trace.go:171","msg":"trace[1639185423] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:803; }","duration":"180.880929ms","start":"2026-04-02T21:24:53.18514Z","end":"2026-04-02T21:24:53.366021Z","steps":["trace[1639185423] 'agreement among raft nodes before linearized reading' (duration: 180.612655ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:53.365988Z","caller":"traceutil/trace.go:171","msg":"trace[1122124688] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:803; }","duration":"103.919577ms","start":"2026-04-02T21:24:53.262005Z","end":"2026-04-02T21:24:53.365924Z","steps":["trace[1122124688] 'agreement among raft nodes before linearized reading' (duration: 103.763465ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:53.366475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.756502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-02T21:24:53.366516Z","caller":"traceutil/trace.go:171","msg":"trace[1078209080] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:803; }","duration":"205.870413ms","start":"2026-04-02T21:24:53.160634Z","end":"2026-04-02T21:24:53.366504Z","steps":["trace[1078209080] 'agreement among raft nodes before linearized reading' (duration: 205.091152ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:53.52479Z","caller":"traceutil/trace.go:171","msg":"trace[45484344] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"154.277211ms","start":"2026-04-02T21:24:53.370482Z","end":"2026-04-02T21:24:53.524759Z","steps":["trace[45484344] 'process raft request' (duration: 66.16335ms)","trace[45484344] 'compare' (duration: 87.920119ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T21:24:53.524871Z","caller":"traceutil/trace.go:171","msg":"trace[855028875] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"154.353572ms","start":"2026-04-02T21:24:53.370482Z","end":"2026-04-02T21:24:53.524836Z","steps":["trace[855028875] 'process raft request' (duration: 154.21876ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:53.525069Z","caller":"traceutil/trace.go:171","msg":"trace[2120122520] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"154.250401ms","start":"2026-04-02T21:24:53.370793Z","end":"2026-04-02T21:24:53.525044Z","steps":["trace[2120122520] 'process raft request' (duration: 153.951027ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:53.525115Z","caller":"traceutil/trace.go:171","msg":"trace[1974238821] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"154.054868ms","start":"2026-04-02T21:24:53.370825Z","end":"2026-04-02T21:24:53.52488Z","steps":["trace[1974238821] 'process raft request' (duration: 153.991577ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:54.290644Z","caller":"traceutil/trace.go:171","msg":"trace[1843039199] linearizableReadLoop","detail":"{readStateIndex:841; appliedIndex:840; }","duration":"357.394148ms","start":"2026-04-02T21:24:53.933219Z","end":"2026-04-02T21:24:54.290613Z","steps":["trace[1843039199] 'read index received' (duration: 357.193815ms)","trace[1843039199] 'applied index is now lower than readState.Index' (duration: 199.233µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T21:24:54.290693Z","caller":"traceutil/trace.go:171","msg":"trace[1081031408] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"358.079368ms","start":"2026-04-02T21:24:53.932579Z","end":"2026-04-02T21:24:54.290658Z","steps":["trace[1081031408] 'process raft request' (duration: 357.858255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:54.290853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:53.932563Z","time spent":"358.21472ms","remote":"127.0.0.1:51908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":884,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T21:24:54.290922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.674353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-02T21:24:54.290984Z","caller":"traceutil/trace.go:171","msg":"trace[1920675093] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:809; }","duration":"357.768764ms","start":"2026-04-02T21:24:53.933198Z","end":"2026-04-02T21:24:54.290966Z","steps":["trace[1920675093] 'agreement among raft nodes before linearized reading' (duration: 357.54477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:54.291091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:53.933189Z","time spent":"357.886405ms","remote":"127.0.0.1:51864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"warn","ts":"2026-04-02T21:24:55.596176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.483407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-02T21:24:55.596236Z","caller":"traceutil/trace.go:171","msg":"trace[129815939] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:818; }","duration":"225.590439ms","start":"2026-04-02T21:24:55.370631Z","end":"2026-04-02T21:24:55.596222Z","steps":["trace[129815939] 'range keys from in-memory index tree' (duration: 225.368656ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:55.596358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.640916ms","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-04-02T21:24:55.596419Z","caller":"traceutil/trace.go:171","msg":"trace[256841789] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:818; }","duration":"219.733548ms","start":"2026-04-02T21:24:55.37667Z","end":"2026-04-02T21:24:55.596404Z","steps":["trace[256841789] 'count revisions from in-memory index tree' (duration: 219.565776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:56.775511Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.175764379s","expected-duration":"1s"} {"level":"info","ts":"2026-04-02T21:24:56.776483Z","caller":"traceutil/trace.go:171","msg":"trace[572616818] transaction","detail":"{read_only:false; response_revision:819; number_of_response:1; }","duration":"1.176807503s","start":"2026-04-02T21:24:55.599656Z","end":"2026-04-02T21:24:56.776464Z","steps":["trace[572616818] 'process raft request' (duration: 1.176085683s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:56.776621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:55.599636Z","time spent":"1.176905725s","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T21:24:57.030507Z","caller":"traceutil/trace.go:171","msg":"trace[1999176157] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"1.430219248s","start":"2026-04-02T21:24:55.60027Z","end":"2026-04-02T21:24:57.030489Z","steps":["trace[1999176157] 'process raft request' (duration: 1.430139987s)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:57.03049Z","caller":"traceutil/trace.go:171","msg":"trace[902115822] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"1.430775315s","start":"2026-04-02T21:24:55.599685Z","end":"2026-04-02T21:24:57.03046Z","steps":["trace[902115822] 'process raft request' (duration: 1.430021675s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:57.030687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:55.600256Z","time spent":"1.43035848s","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T21:24:57.03065Z","caller":"traceutil/trace.go:171","msg":"trace[263148058] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"1.430657334s","start":"2026-04-02T21:24:55.599956Z","end":"2026-04-02T21:24:57.030614Z","steps":["trace[263148058] 'process raft request' (duration: 1.430138716s)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:57.030753Z","caller":"traceutil/trace.go:171","msg":"trace[1216879298] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"1.430461871s","start":"2026-04-02T21:24:55.600281Z","end":"2026-04-02T21:24:57.030743Z","steps":["trace[1216879298] 'process raft request' (duration: 1.430175727s)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:57.030779Z","caller":"traceutil/trace.go:171","msg":"trace[2016249286] linearizableReadLoop","detail":"{readStateIndex:856; appliedIndex:850; }","duration":"451.664693ms","start":"2026-04-02T21:24:56.579091Z","end":"2026-04-02T21:24:57.030755Z","steps":["trace[2016249286] 'read index received' (duration: 196.671976ms)","trace[2016249286] 'applied index is now lower than readState.Index' (duration: 254.991797ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T21:24:57.030805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:55.600268Z","time spent":"1.430511152s","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T21:24:57.030859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:55.599931Z","time spent":"1.430828437s","remote":"127.0.0.1:52074","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-04-02T21:24:57.030908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.795864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T21:24:57.030929Z","caller":"traceutil/trace.go:171","msg":"trace[1248397869] transaction","detail":"{read_only:false; response_revision:824; number_of_response:1; }","duration":"1.082549027s","start":"2026-04-02T21:24:55.948364Z","end":"2026-04-02T21:24:57.030913Z","steps":["trace[1248397869] 'process raft request' (duration: 1.082266673s)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:57.030942Z","caller":"traceutil/trace.go:171","msg":"trace[1821691443] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:824; }","duration":"451.867825ms","start":"2026-04-02T21:24:56.579063Z","end":"2026-04-02T21:24:57.030931Z","steps":["trace[1821691443] 'agreement among raft nodes before linearized reading' (duration: 451.779234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:57.030983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:55.948338Z","time spent":"1.082616177s","remote":"127.0.0.1:52044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T21:24:57.030694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:55.59967Z","time spent":"1.430952808s","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T21:24:57.030987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:24:56.579049Z","time spent":"451.930436ms","remote":"127.0.0.1:51806","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-04-02T21:24:59.181703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.331046ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-02T21:24:59.181815Z","caller":"traceutil/trace.go:171","msg":"trace[1286621581] linearizableReadLoop","detail":"{readStateIndex:862; appliedIndex:861; }","duration":"146.163834ms","start":"2026-04-02T21:24:59.035637Z","end":"2026-04-02T21:24:59.181801Z","steps":["trace[1286621581] 'read index received' (duration: 30.47µs)","trace[1286621581] 'applied index is now lower than readState.Index' (duration: 146.132144ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T21:24:59.181981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.334886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-02T21:24:59.182016Z","caller":"traceutil/trace.go:171","msg":"trace[2117086426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:829; }","duration":"146.413078ms","start":"2026-04-02T21:24:59.035594Z","end":"2026-04-02T21:24:59.182007Z","steps":["trace[2117086426] 'agreement among raft nodes before linearized reading' (duration: 146.285726ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:59.18204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.131294ms","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-04-02T21:24:59.1821Z","caller":"traceutil/trace.go:171","msg":"trace[1622586958] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:829; }","duration":"146.252565ms","start":"2026-04-02T21:24:59.035833Z","end":"2026-04-02T21:24:59.182086Z","steps":["trace[1622586958] 'agreement among raft nodes before linearized reading' (duration: 146.086002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:24:59.182105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.015748ms","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-04-02T21:24:59.182104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.132409ms","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-04-02T21:24:59.182218Z","caller":"traceutil/trace.go:171","msg":"trace[1949836826] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:829; }","duration":"145.15295ms","start":"2026-04-02T21:24:59.037042Z","end":"2026-04-02T21:24:59.182195Z","steps":["trace[1949836826] 'agreement among raft nodes before linearized reading' (duration: 144.893977ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:24:59.182251Z","caller":"traceutil/trace.go:171","msg":"trace[898825105] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:829; }","duration":"145.318092ms","start":"2026-04-02T21:24:59.036922Z","end":"2026-04-02T21:24:59.18224Z","steps":["trace[898825105] 'agreement among raft nodes before linearized reading' (duration: 145.056328ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:26:15.047078Z","caller":"traceutil/trace.go:171","msg":"trace[248863010] linearizableReadLoop","detail":"{readStateIndex:1256; appliedIndex:1255; }","duration":"467.601047ms","start":"2026-04-02T21:26:14.579457Z","end":"2026-04-02T21:26:15.047058Z","steps":["trace[248863010] 'read index received' (duration: 467.341114ms)","trace[248863010] 'applied index is now lower than readState.Index' (duration: 259.223µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T21:26:15.047237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.759428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T21:26:15.047261Z","caller":"traceutil/trace.go:171","msg":"trace[1237077882] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1208; }","duration":"467.829188ms","start":"2026-04-02T21:26:14.579424Z","end":"2026-04-02T21:26:15.047253Z","steps":["trace[1237077882] 'agreement among raft nodes before linearized reading' (duration: 467.728087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:26:15.047285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:26:14.579409Z","time spent":"467.870839ms","remote":"127.0.0.1:51814","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-04-02T21:26:15.047425Z","caller":"traceutil/trace.go:171","msg":"trace[1287201182] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"678.10683ms","start":"2026-04-02T21:26:14.369269Z","end":"2026-04-02T21:26:15.047376Z","steps":["trace[1287201182] 'process raft request' (duration: 677.601905ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:26:15.047648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:26:14.369249Z","time spent":"678.273631ms","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T21:26:33.297038Z","caller":"traceutil/trace.go:171","msg":"trace[650600350] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"147.977169ms","start":"2026-04-02T21:26:33.149045Z","end":"2026-04-02T21:26:33.297022Z","steps":["trace[650600350] 'process raft request' (duration: 147.712756ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:26:54.155303Z","caller":"traceutil/trace.go:171","msg":"trace[1143289004] linearizableReadLoop","detail":"{readStateIndex:1424; appliedIndex:1423; }","duration":"277.444828ms","start":"2026-04-02T21:26:53.877831Z","end":"2026-04-02T21:26:54.155276Z","steps":["trace[1143289004] 'read index received' (duration: 277.250516ms)","trace[1143289004] 'applied index is now lower than readState.Index' (duration: 193.122µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T21:26:54.155427Z","caller":"traceutil/trace.go:171","msg":"trace[1777969281] transaction","detail":"{read_only:false; response_revision:1367; number_of_response:1; }","duration":"500.569894ms","start":"2026-04-02T21:26:53.654813Z","end":"2026-04-02T21:26:54.155383Z","steps":["trace[1777969281] 'process raft request' (duration: 500.294921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:26:54.155623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:26:53.65478Z","time spent":"500.742366ms","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T21:26:54.155628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.133992ms","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-04-02T21:26:54.155686Z","caller":"traceutil/trace.go:171","msg":"trace[1190981438] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1367; }","duration":"271.267773ms","start":"2026-04-02T21:26:53.884403Z","end":"2026-04-02T21:26:54.15567Z","steps":["trace[1190981438] 'agreement among raft nodes before linearized reading' (duration: 271.063082ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:26:54.155731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.862111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.207\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-02T21:26:54.155936Z","caller":"traceutil/trace.go:171","msg":"trace[843979062] range","detail":"{range_begin:/registry/masterleases/199.19.213.207; range_end:; response_count:1; response_revision:1367; }","duration":"278.096364ms","start":"2026-04-02T21:26:53.877785Z","end":"2026-04-02T21:26:54.155881Z","steps":["trace[843979062] 'agreement among raft nodes before linearized reading' (duration: 277.64872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:26:54.155997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.847239ms","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-04-02T21:26:54.156085Z","caller":"traceutil/trace.go:171","msg":"trace[1315810878] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1367; }","duration":"206.965741ms","start":"2026-04-02T21:26:53.949092Z","end":"2026-04-02T21:26:54.156058Z","steps":["trace[1315810878] 'agreement among raft nodes before linearized reading' (duration: 206.720279ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:27:04.319357Z","caller":"traceutil/trace.go:171","msg":"trace[151016091] linearizableReadLoop","detail":"{readStateIndex:1466; appliedIndex:1465; }","duration":"117.248846ms","start":"2026-04-02T21:27:04.202077Z","end":"2026-04-02T21:27:04.319326Z","steps":["trace[151016091] 'read index received' (duration: 117.017744ms)","trace[151016091] 'applied index is now lower than readState.Index' (duration: 229.942µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T21:27:04.319513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:27:03.880397Z","time spent":"439.112345ms","remote":"127.0.0.1:51864","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-02T21:27:04.320263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.169834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-02T21:27:04.320317Z","caller":"traceutil/trace.go:171","msg":"trace[85965681] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1406; }","duration":"118.279166ms","start":"2026-04-02T21:27:04.202023Z","end":"2026-04-02T21:27:04.320302Z","steps":["trace[85965681] 'agreement among raft nodes before linearized reading' (duration: 118.156674ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T21:27:06.647739Z","caller":"traceutil/trace.go:171","msg":"trace[1648138892] transaction","detail":"{read_only:false; response_revision:1418; number_of_response:1; }","duration":"235.425864ms","start":"2026-04-02T21:27:06.412281Z","end":"2026-04-02T21:27:06.647707Z","steps":["trace[1648138892] 'process raft request' (duration: 235.252493ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:27:06.831019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.061039ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T21:27:06.831616Z","caller":"traceutil/trace.go:171","msg":"trace[874175798] transaction","detail":"{read_only:false; response_revision:1419; number_of_response:1; }","duration":"416.936469ms","start":"2026-04-02T21:27:06.414655Z","end":"2026-04-02T21:27:06.831592Z","steps":["trace[874175798] 'process raft request' (duration: 297.219154ms)","trace[874175798] 'compare' (duration: 118.955128ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T21:27:06.831618Z","caller":"traceutil/trace.go:171","msg":"trace[876581281] transaction","detail":"{read_only:false; response_revision:1420; number_of_response:1; }","duration":"416.896909ms","start":"2026-04-02T21:27:06.4147Z","end":"2026-04-02T21:27:06.831596Z","steps":["trace[876581281] 'process raft request' (duration: 416.455995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:27:06.831692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:27:06.414631Z","time spent":"417.02735ms","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T21:27:06.832061Z","caller":"traceutil/trace.go:171","msg":"trace[1188176453] transaction","detail":"{read_only:false; response_revision:1421; number_of_response:1; }","duration":"417.336613ms","start":"2026-04-02T21:27:06.414715Z","end":"2026-04-02T21:27:06.832052Z","steps":["trace[1188176453] 'process raft request' (duration: 416.510275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:27:06.831719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:27:06.414671Z","time spent":"416.995589ms","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T21:27:06.832364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:27:06.414706Z","time spent":"417.379033ms","remote":"127.0.0.1:52074","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-04-02T21:27:06.832749Z","caller":"traceutil/trace.go:171","msg":"trace[819680185] transaction","detail":"{read_only:false; response_revision:1422; number_of_response:1; }","duration":"416.597936ms","start":"2026-04-02T21:27:06.416119Z","end":"2026-04-02T21:27:06.832717Z","steps":["trace[819680185] 'process raft request' (duration: 415.146614ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:27:06.833204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.48523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T21:27:06.833249Z","caller":"traceutil/trace.go:171","msg":"trace[997199498] linearizableReadLoop","detail":"{readStateIndex:1483; appliedIndex:1478; }","duration":"269.948606ms","start":"2026-04-02T21:27:06.562711Z","end":"2026-04-02T21:27:06.83266Z","steps":["trace[997199498] 'read index received' (duration: 84.84601ms)","trace[997199498] 'applied index is now lower than readState.Index' (duration: 185.098986ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T21:27:06.833273Z","caller":"traceutil/trace.go:171","msg":"trace[1000905029] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1422; }","duration":"270.603422ms","start":"2026-04-02T21:27:06.562653Z","end":"2026-04-02T21:27:06.833257Z","steps":["trace[1000905029] 'agreement among raft nodes before linearized reading' (duration: 270.486551ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T21:27:06.833402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T21:27:06.41611Z","time spent":"417.0261ms","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T21:27:06.83353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.36762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T21:27:06.833675Z","caller":"traceutil/trace.go:171","msg":"trace[1762864196] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1422; }","duration":"254.568623ms","start":"2026-04-02T21:27:06.579095Z","end":"2026-04-02T21:27:06.833663Z","steps":["trace[1762864196] 'agreement among raft nodes before linearized reading' (duration: 254.386271ms)"],"step_count":1}