{"level":"warn","ts":"2026-07-28T19:35:31.042456Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-28T19:35:31.042576Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4: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-07-28T19:35:31.042659Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-28T19:35:31.042668Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-07-28T19:35:31.042733Z","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-07-28T19:35:31.044053Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]} {"level":"info","ts":"2026-07-28T19:35:31.044157Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4: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-07-28T19:35:31.04614Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.642161ms"} {"level":"info","ts":"2026-07-28T19:35:31.05356Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"} {"level":"info","ts":"2026-07-28T19:35:31.053672Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"} {"level":"info","ts":"2026-07-28T19:35:31.053705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"} {"level":"info","ts":"2026-07-28T19:35:31.053715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-28T19:35:31.053727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"} {"level":"info","ts":"2026-07-28T19:35:31.053861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"warn","ts":"2026-07-28T19:35:31.05857Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-28T19:35:31.059826Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-28T19:35:31.060776Z","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-07-28T19:35:31.062567Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-28T19:35:31.062654Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-28T19:35:31.062795Z","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-07-28T19:35:31.062857Z","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-07-28T19:35:31.062868Z","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-07-28T19:35:31.065197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"info","ts":"2026-07-28T19:35:31.065418Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-07-28T19:35:31.066406Z","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-07-28T19:35:31.066536Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-07-28T19:35:31.066624Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-07-28T19:35:31.066646Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-28T19:35:31.066667Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-28T19:35:31.556051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"} {"level":"info","ts":"2026-07-28T19:35:31.556136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"} {"level":"info","ts":"2026-07-28T19:35:31.556177Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"} {"level":"info","ts":"2026-07-28T19:35:31.556195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"} {"level":"info","ts":"2026-07-28T19:35:31.556202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-07-28T19:35:31.556213Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"} {"level":"info","ts":"2026-07-28T19:35:31.556223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-07-28T19:35:31.562995Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"} {"level":"info","ts":"2026-07-28T19:35:31.563016Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-28T19:35:31.563142Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-28T19:35:31.563514Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-28T19:35:31.563531Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-28T19:35:31.564877Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"} {"level":"info","ts":"2026-07-28T19:35:31.566884Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-28T19:35:31.567785Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"} {"level":"info","ts":"2026-07-28T19:35:31.567838Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-28T19:35:31.567853Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-28T19:35:31.569727Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-28T19:36:07.690208Z","caller":"traceutil/trace.go:171","msg":"trace[1381415705] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"180.85913ms","start":"2026-07-28T19:36:07.509327Z","end":"2026-07-28T19:36:07.690186Z","steps":["trace[1381415705] 'process raft request' (duration: 180.735177ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:36:13.548491Z","caller":"traceutil/trace.go:171","msg":"trace[1550238703] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"198.343454ms","start":"2026-07-28T19:36:13.350119Z","end":"2026-07-28T19:36:13.548462Z","steps":["trace[1550238703] 'process raft request' (duration: 197.760339ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:36:13.967879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.399317ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-28T19:36:13.968051Z","caller":"traceutil/trace.go:171","msg":"trace[1891466435] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"212.635889ms","start":"2026-07-28T19:36:13.755395Z","end":"2026-07-28T19:36:13.968031Z","steps":["trace[1891466435] 'read index received' (duration: 37.191µs)","trace[1891466435] 'applied index is now lower than readState.Index' (duration: 212.596948ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T19:36:13.968179Z","caller":"traceutil/trace.go:171","msg":"trace[1460902186] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"365.936334ms","start":"2026-07-28T19:36:13.602104Z","end":"2026-07-28T19:36:13.96804Z","steps":["trace[1460902186] 'process raft request' (duration: 97.635544ms)","trace[1460902186] 'compare' (duration: 267.292434ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T19:36:13.968259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.859744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4jn2f\" ","response":"range_response_count:1 size:16957"} {"level":"info","ts":"2026-07-28T19:36:13.968294Z","caller":"traceutil/trace.go:171","msg":"trace[734034708] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4jn2f; range_end:; response_count:1; response_revision:629; }","duration":"212.944806ms","start":"2026-07-28T19:36:13.755339Z","end":"2026-07-28T19:36:13.968284Z","steps":["trace[734034708] 'agreement among raft nodes before linearized reading' (duration: 212.811733ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:36:13.968349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.387323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-28T19:36:13.968336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:36:13.602085Z","time spent":"366.1727ms","remote":"127.0.0.1:35666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-28T19:36:13.968421Z","caller":"traceutil/trace.go:171","msg":"trace[1992858614] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:629; }","duration":"206.472076ms","start":"2026-07-28T19:36:13.761931Z","end":"2026-07-28T19:36:13.968403Z","steps":["trace[1992858614] 'agreement among raft nodes before linearized reading' (duration: 206.268241ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:36:13.968625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.372126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-28T19:36:13.968689Z","caller":"traceutil/trace.go:171","msg":"trace[1096363887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:629; }","duration":"163.460537ms","start":"2026-07-28T19:36:13.805211Z","end":"2026-07-28T19:36:13.968672Z","steps":["trace[1096363887] 'agreement among raft nodes before linearized reading' (duration: 163.238942ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:36:14.28343Z","caller":"traceutil/trace.go:171","msg":"trace[1201949964] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"296.821309ms","start":"2026-07-28T19:36:13.98646Z","end":"2026-07-28T19:36:14.283281Z","steps":["trace[1201949964] 'process raft request' (duration: 233.868696ms)","trace[1201949964] 'compare' (duration: 62.811189ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T19:36:15.061026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.522369ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-28T19:36:15.061306Z","caller":"traceutil/trace.go:171","msg":"trace[1112225458] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"698.838028ms","start":"2026-07-28T19:36:14.362444Z","end":"2026-07-28T19:36:15.061282Z","steps":["trace[1112225458] 'process raft request' (duration: 418.794927ms)","trace[1112225458] 'compare' (duration: 279.381675ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T19:36:15.061403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:36:14.362429Z","time spent":"698.92958ms","remote":"127.0.0.1:35548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T19:36:15.088007Z","caller":"traceutil/trace.go:171","msg":"trace[1202034251] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"700.16301ms","start":"2026-07-28T19:36:14.387809Z","end":"2026-07-28T19:36:15.087972Z","steps":["trace[1202034251] 'process raft request' (duration: 692.89767ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:36:15.088148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:36:14.387784Z","time spent":"700.289953ms","remote":"127.0.0.1:35384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T19:36:15.088539Z","caller":"traceutil/trace.go:171","msg":"trace[399848545] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:653; }","duration":"220.999766ms","start":"2026-07-28T19:36:14.867511Z","end":"2026-07-28T19:36:15.08851Z","steps":["trace[399848545] 'read index received' (duration: 212.455773ms)","trace[399848545] 'applied index is now lower than readState.Index' (duration: 8.542722ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T19:36:15.088824Z","caller":"traceutil/trace.go:171","msg":"trace[672527305] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"277.637822ms","start":"2026-07-28T19:36:14.81116Z","end":"2026-07-28T19:36:15.088798Z","steps":["trace[672527305] 'process raft request' (duration: 276.725588ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:36:15.088882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.378035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-28T19:36:15.088908Z","caller":"traceutil/trace.go:171","msg":"trace[775284930] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:635; }","duration":"221.443607ms","start":"2026-07-28T19:36:14.867457Z","end":"2026-07-28T19:36:15.088901Z","steps":["trace[775284930] 'agreement among raft nodes before linearized reading' (duration: 221.15074ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:36:30.29371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.948163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4snsk\" ","response":"range_response_count:1 size:3963"} {"level":"info","ts":"2026-07-28T19:36:30.293802Z","caller":"traceutil/trace.go:171","msg":"trace[1733425546] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4snsk; range_end:; response_count:1; response_revision:796; }","duration":"424.081917ms","start":"2026-07-28T19:36:29.869703Z","end":"2026-07-28T19:36:30.293785Z","steps":["trace[1733425546] 'range keys from in-memory index tree' (duration: 423.82951ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:36:30.293843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:36:29.869686Z","time spent":"424.148279ms","remote":"127.0.0.1:35494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3986,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4snsk\" "} {"level":"warn","ts":"2026-07-28T19:36:30.29411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.714596ms","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-07-28T19:36:30.294146Z","caller":"traceutil/trace.go:171","msg":"trace[815473672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:796; }","duration":"209.777917ms","start":"2026-07-28T19:36:30.084359Z","end":"2026-07-28T19:36:30.294137Z","steps":["trace[815473672] 'range keys from in-memory index tree' (duration: 209.605962ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:36:30.294303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.255411ms","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-07-28T19:36:30.294386Z","caller":"traceutil/trace.go:171","msg":"trace[27381474] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:796; }","duration":"208.393284ms","start":"2026-07-28T19:36:30.085975Z","end":"2026-07-28T19:36:30.294368Z","steps":["trace[27381474] 'range keys from in-memory index tree' (duration: 208.073346ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:37:05.713553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.779321ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-28T19:37:05.713804Z","caller":"traceutil/trace.go:171","msg":"trace[109334523] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"470.309241ms","start":"2026-07-28T19:37:05.243476Z","end":"2026-07-28T19:37:05.713785Z","steps":["trace[109334523] 'process raft request' (duration: 470.191069ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:37:05.713804Z","caller":"traceutil/trace.go:171","msg":"trace[834583809] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"587.208219ms","start":"2026-07-28T19:37:05.126568Z","end":"2026-07-28T19:37:05.713776Z","steps":["trace[834583809] 'process raft request' (duration: 272.1038ms)","trace[834583809] 'compare' (duration: 314.548486ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T19:37:05.71388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:37:05.243447Z","time spent":"470.400294ms","remote":"127.0.0.1:35548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-28T19:37:05.713939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:37:05.126547Z","time spent":"587.315382ms","remote":"127.0.0.1:35318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":116,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T19:37:05.714235Z","caller":"traceutil/trace.go:171","msg":"trace[1701662271] linearizableReadLoop","detail":"{readStateIndex:1043; appliedIndex:1042; }","duration":"489.653373ms","start":"2026-07-28T19:37:05.224243Z","end":"2026-07-28T19:37:05.713896Z","steps":["trace[1701662271] 'read index received' (duration: 174.352269ms)","trace[1701662271] 'applied index is now lower than readState.Index' (duration: 315.291864ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T19:37:05.714322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.079023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T19:37:05.714514Z","caller":"traceutil/trace.go:171","msg":"trace[800016212] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1010; }","duration":"490.319659ms","start":"2026-07-28T19:37:05.224181Z","end":"2026-07-28T19:37:05.714501Z","steps":["trace[800016212] 'agreement among raft nodes before linearized reading' (duration: 490.098864ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:37:05.714574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:37:05.224165Z","time spent":"490.39707ms","remote":"127.0.0.1:35710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"warn","ts":"2026-07-28T19:37:05.714747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.929649ms","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-07-28T19:37:05.714814Z","caller":"traceutil/trace.go:171","msg":"trace[982306950] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1010; }","duration":"414.051592ms","start":"2026-07-28T19:37:05.300751Z","end":"2026-07-28T19:37:05.714802Z","steps":["trace[982306950] 'agreement among raft nodes before linearized reading' (duration: 413.786255ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:37:05.71488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:37:05.30073Z","time spent":"414.139034ms","remote":"127.0.0.1:35548","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-07-28T19:37:05.714977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.26123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-28T19:37:05.715017Z","caller":"traceutil/trace.go:171","msg":"trace[1864130465] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1010; }","duration":"345.338772ms","start":"2026-07-28T19:37:05.369668Z","end":"2026-07-28T19:37:05.715007Z","steps":["trace[1864130465] 'agreement among raft nodes before linearized reading' (duration: 345.214309ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:37:05.715052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:37:05.369628Z","time spent":"345.417034ms","remote":"127.0.0.1:35548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-28T19:37:05.715043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.716258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T19:37:05.715115Z","caller":"traceutil/trace.go:171","msg":"trace[477680401] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1010; }","duration":"379.82192ms","start":"2026-07-28T19:37:05.335273Z","end":"2026-07-28T19:37:05.715095Z","steps":["trace[477680401] 'agreement among raft nodes before linearized reading' (duration: 379.682267ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:37:05.715156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:37:05.335258Z","time spent":"379.892602ms","remote":"127.0.0.1:35296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-28T19:37:05.984788Z","caller":"traceutil/trace.go:171","msg":"trace[1940881012] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"265.724632ms","start":"2026-07-28T19:37:05.719032Z","end":"2026-07-28T19:37:05.984756Z","steps":["trace[1940881012] 'process raft request' (duration: 265.23357ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:37:05.987116Z","caller":"traceutil/trace.go:171","msg":"trace[269455629] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"267.26143ms","start":"2026-07-28T19:37:05.719837Z","end":"2026-07-28T19:37:05.987098Z","steps":["trace[269455629] 'process raft request' (duration: 267.122226ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:37:05.98729Z","caller":"traceutil/trace.go:171","msg":"trace[1449014701] linearizableReadLoop","detail":"{readStateIndex:1046; appliedIndex:1044; }","duration":"267.066175ms","start":"2026-07-28T19:37:05.720195Z","end":"2026-07-28T19:37:05.987261Z","steps":["trace[1449014701] 'read index received' (duration: 264.094961ms)","trace[1449014701] 'applied index is now lower than readState.Index' (duration: 2.968974ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T19:37:05.98735Z","caller":"traceutil/trace.go:171","msg":"trace[2074319012] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"116.291283ms","start":"2026-07-28T19:37:05.871017Z","end":"2026-07-28T19:37:05.987309Z","steps":["trace[2074319012] 'process raft request' (duration: 116.028927ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:37:05.987445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.23678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-28T19:37:05.987485Z","caller":"traceutil/trace.go:171","msg":"trace[1684138879] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1013; }","duration":"267.328542ms","start":"2026-07-28T19:37:05.720145Z","end":"2026-07-28T19:37:05.987473Z","steps":["trace[1684138879] 'agreement among raft nodes before linearized reading' (duration: 267.213029ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:37:30.267415Z","caller":"traceutil/trace.go:171","msg":"trace[1358066790] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"147.061209ms","start":"2026-07-28T19:37:30.120321Z","end":"2026-07-28T19:37:30.267382Z","steps":["trace[1358066790] 'process raft request' (duration: 146.866244ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:37:30.293848Z","caller":"traceutil/trace.go:171","msg":"trace[1043597600] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"172.967413ms","start":"2026-07-28T19:37:30.120841Z","end":"2026-07-28T19:37:30.293809Z","steps":["trace[1043597600] 'process raft request' (duration: 172.701286ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:37:32.520397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.706161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-28T19:37:32.520517Z","caller":"traceutil/trace.go:171","msg":"trace[1480619101] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1097; }","duration":"222.875535ms","start":"2026-07-28T19:37:32.297599Z","end":"2026-07-28T19:37:32.520475Z","steps":["trace[1480619101] 'range keys from in-memory index tree' (duration: 222.505596ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:37:50.890538Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232313012810676313,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-28T19:37:51.091715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.711406ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-28T19:37:51.09183Z","caller":"traceutil/trace.go:171","msg":"trace[229515186] linearizableReadLoop","detail":"{readStateIndex:1252; appliedIndex:1251; }","duration":"701.634089ms","start":"2026-07-28T19:37:50.390177Z","end":"2026-07-28T19:37:51.091811Z","steps":["trace[229515186] 'read index received' (duration: 594.878073ms)","trace[229515186] 'applied index is now lower than readState.Index' (duration: 106.754566ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T19:37:51.092074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.893685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-28T19:37:51.092104Z","caller":"traceutil/trace.go:171","msg":"trace[2040246645] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1207; }","duration":"701.968387ms","start":"2026-07-28T19:37:50.390124Z","end":"2026-07-28T19:37:51.092093Z","steps":["trace[2040246645] 'agreement among raft nodes before linearized reading' (duration: 701.774842ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:37:51.092133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:37:50.390104Z","time spent":"702.022999ms","remote":"127.0.0.1:35548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-28T19:37:51.092177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.462846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-28T19:37:51.092282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.049215ms","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-07-28T19:37:51.092331Z","caller":"traceutil/trace.go:171","msg":"trace[322753125] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1207; }","duration":"140.137957ms","start":"2026-07-28T19:37:50.952179Z","end":"2026-07-28T19:37:51.092317Z","steps":["trace[322753125] 'agreement among raft nodes before linearized reading' (duration: 140.057375ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:37:51.092385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.874916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-28T19:37:51.092422Z","caller":"traceutil/trace.go:171","msg":"trace[1118941965] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1207; }","duration":"173.942528ms","start":"2026-07-28T19:37:50.918471Z","end":"2026-07-28T19:37:51.092413Z","steps":["trace[1118941965] 'agreement among raft nodes before linearized reading' (duration: 173.842865ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:37:51.09228Z","caller":"traceutil/trace.go:171","msg":"trace[857831899] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1207; }","duration":"433.6155ms","start":"2026-07-28T19:37:50.658635Z","end":"2026-07-28T19:37:51.092251Z","steps":["trace[857831899] 'agreement among raft nodes before linearized reading' (duration: 433.341043ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:37:51.092529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:37:50.658615Z","time spent":"433.896366ms","remote":"127.0.0.1:35548","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-07-28T19:37:51.092191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.579911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-28T19:37:51.092603Z","caller":"traceutil/trace.go:171","msg":"trace[392227268] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1207; }","duration":"154.025543ms","start":"2026-07-28T19:37:50.938563Z","end":"2026-07-28T19:37:51.092588Z","steps":["trace[392227268] 'agreement among raft nodes before linearized reading' (duration: 153.453449ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:37:51.228638Z","caller":"traceutil/trace.go:171","msg":"trace[1442367907] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"129.02431ms","start":"2026-07-28T19:37:51.099588Z","end":"2026-07-28T19:37:51.228612Z","steps":["trace[1442367907] 'process raft request' (duration: 128.749303ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:37:51.231821Z","caller":"traceutil/trace.go:171","msg":"trace[464529273] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"132.063786ms","start":"2026-07-28T19:37:51.099746Z","end":"2026-07-28T19:37:51.23181Z","steps":["trace[464529273] 'process raft request' (duration: 131.80423ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:37:51.232098Z","caller":"traceutil/trace.go:171","msg":"trace[799835116] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"132.264001ms","start":"2026-07-28T19:37:51.099826Z","end":"2026-07-28T19:37:51.23209Z","steps":["trace[799835116] 'process raft request' (duration: 131.81312ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:37:51.233723Z","caller":"traceutil/trace.go:171","msg":"trace[1807665432] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"133.882921ms","start":"2026-07-28T19:37:51.099829Z","end":"2026-07-28T19:37:51.233712Z","steps":["trace[1807665432] 'process raft request' (duration: 131.838921ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:37:51.233931Z","caller":"traceutil/trace.go:171","msg":"trace[1375085391] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"134.050564ms","start":"2026-07-28T19:37:51.09987Z","end":"2026-07-28T19:37:51.233921Z","steps":["trace[1375085391] 'process raft request' (duration: 134.002073ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:38:07.489487Z","caller":"traceutil/trace.go:171","msg":"trace[2097589369] linearizableReadLoop","detail":"{readStateIndex:1328; appliedIndex:1327; }","duration":"185.32149ms","start":"2026-07-28T19:38:07.304137Z","end":"2026-07-28T19:38:07.489459Z","steps":["trace[2097589369] 'read index received' (duration: 185.227708ms)","trace[2097589369] 'applied index is now lower than readState.Index' (duration: 92.532µs)"],"step_count":2} {"level":"info","ts":"2026-07-28T19:38:07.489602Z","caller":"traceutil/trace.go:171","msg":"trace[1696231431] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"186.50154ms","start":"2026-07-28T19:38:07.303067Z","end":"2026-07-28T19:38:07.489568Z","steps":["trace[1696231431] 'process raft request' (duration: 186.224733ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:38:07.489697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.544675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-28T19:38:07.489778Z","caller":"traceutil/trace.go:171","msg":"trace[1664492026] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1280; }","duration":"185.650239ms","start":"2026-07-28T19:38:07.304116Z","end":"2026-07-28T19:38:07.489767Z","steps":["trace[1664492026] 'agreement among raft nodes before linearized reading' (duration: 185.463404ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:38:07.505613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.408816ms","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-07-28T19:38:07.505665Z","caller":"traceutil/trace.go:171","msg":"trace[1380633501] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1281; }","duration":"200.475908ms","start":"2026-07-28T19:38:07.305177Z","end":"2026-07-28T19:38:07.505653Z","steps":["trace[1380633501] 'agreement among raft nodes before linearized reading' (duration: 200.337405ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:38:07.505906Z","caller":"traceutil/trace.go:171","msg":"trace[737802413] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"186.960871ms","start":"2026-07-28T19:38:07.318934Z","end":"2026-07-28T19:38:07.505895Z","steps":["trace[737802413] 'process raft request' (duration: 186.50079ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:38:07.506056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.769619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T19:38:07.506083Z","caller":"traceutil/trace.go:171","msg":"trace[2062014075] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1281; }","duration":"172.81523ms","start":"2026-07-28T19:38:07.333259Z","end":"2026-07-28T19:38:07.506074Z","steps":["trace[2062014075] 'agreement among raft nodes before linearized reading' (duration: 172.771059ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:38:07.506285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.53878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-28T19:38:07.506328Z","caller":"traceutil/trace.go:171","msg":"trace[1384328625] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1281; }","duration":"198.58224ms","start":"2026-07-28T19:38:07.307725Z","end":"2026-07-28T19:38:07.506308Z","steps":["trace[1384328625] 'agreement among raft nodes before linearized reading' (duration: 198.475788ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:38:07.50639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.56008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-28T19:38:07.506466Z","caller":"traceutil/trace.go:171","msg":"trace[1853195797] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1281; }","duration":"198.684673ms","start":"2026-07-28T19:38:07.307761Z","end":"2026-07-28T19:38:07.506446Z","steps":["trace[1853195797] 'agreement among raft nodes before linearized reading' (duration: 198.426126ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:38:08.904219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.069684ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-28T19:38:08.904782Z","caller":"traceutil/trace.go:171","msg":"trace[915491764] linearizableReadLoop","detail":"{readStateIndex:1338; appliedIndex:1337; }","duration":"791.685038ms","start":"2026-07-28T19:38:08.113082Z","end":"2026-07-28T19:38:08.904767Z","steps":["trace[915491764] 'read index received' (duration: 272.025349ms)","trace[915491764] 'applied index is now lower than readState.Index' (duration: 519.658239ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T19:38:08.904847Z","caller":"traceutil/trace.go:171","msg":"trace[1003918772] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"808.595809ms","start":"2026-07-28T19:38:08.096245Z","end":"2026-07-28T19:38:08.90484Z","steps":["trace[1003918772] 'process raft request' (duration: 288.824497ms)","trace[1003918772] 'compare' (duration: 518.638394ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T19:38:08.904875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:38:08.096231Z","time spent":"808.629479ms","remote":"127.0.0.1:35358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-28T19:38:08.905113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.176382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-28T19:38:08.905148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.027136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T19:38:08.905211Z","caller":"traceutil/trace.go:171","msg":"trace[826533523] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1290; }","duration":"569.324105ms","start":"2026-07-28T19:38:08.335864Z","end":"2026-07-28T19:38:08.905188Z","steps":["trace[826533523] 'agreement among raft nodes before linearized reading' (duration: 569.136081ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:38:08.905165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.554853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-28T19:38:08.905252Z","caller":"traceutil/trace.go:171","msg":"trace[1441159800] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1290; }","duration":"792.17235ms","start":"2026-07-28T19:38:08.113054Z","end":"2026-07-28T19:38:08.905226Z","steps":["trace[1441159800] 'agreement among raft nodes before linearized reading' (duration: 791.942555ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:38:08.905318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:38:08.113041Z","time spent":"792.267162ms","remote":"127.0.0.1:35548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-07-28T19:38:08.905334Z","caller":"traceutil/trace.go:171","msg":"trace[2073162582] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1290; }","duration":"639.741907ms","start":"2026-07-28T19:38:08.265565Z","end":"2026-07-28T19:38:08.905307Z","steps":["trace[2073162582] 'agreement among raft nodes before linearized reading' (duration: 639.43373ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:38:08.905391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:38:08.264589Z","time spent":"640.789943ms","remote":"127.0.0.1:53060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":4,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-07-28T19:38:08.905258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:38:08.335844Z","time spent":"569.407108ms","remote":"127.0.0.1:35286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-28T19:38:09.106977Z","caller":"traceutil/trace.go:171","msg":"trace[921174779] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"198.275282ms","start":"2026-07-28T19:38:08.908664Z","end":"2026-07-28T19:38:09.106939Z","steps":["trace[921174779] 'process raft request' (duration: 131.965063ms)","trace[921174779] 'compare' (duration: 66.114264ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T19:38:09.695226Z","caller":"traceutil/trace.go:171","msg":"trace[1123866499] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"195.818961ms","start":"2026-07-28T19:38:09.499388Z","end":"2026-07-28T19:38:09.695207Z","steps":["trace[1123866499] 'process raft request' (duration: 195.698638ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:38:09.695262Z","caller":"traceutil/trace.go:171","msg":"trace[1640063732] linearizableReadLoop","detail":"{readStateIndex:1342; appliedIndex:1341; }","duration":"173.515786ms","start":"2026-07-28T19:38:09.521724Z","end":"2026-07-28T19:38:09.69524Z","steps":["trace[1640063732] 'read index received' (duration: 173.292201ms)","trace[1640063732] 'applied index is now lower than readState.Index' (duration: 220.675µs)"],"step_count":2} {"level":"warn","ts":"2026-07-28T19:38:09.695425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.405717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-28T19:38:09.69543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.701942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-28T19:38:09.69545Z","caller":"traceutil/trace.go:171","msg":"trace[1045388082] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1294; }","duration":"155.467898ms","start":"2026-07-28T19:38:09.539975Z","end":"2026-07-28T19:38:09.695443Z","steps":["trace[1045388082] 'agreement among raft nodes before linearized reading' (duration: 155.369055ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:38:09.695459Z","caller":"traceutil/trace.go:171","msg":"trace[1967600502] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1294; }","duration":"173.768314ms","start":"2026-07-28T19:38:09.521682Z","end":"2026-07-28T19:38:09.69545Z","steps":["trace[1967600502] 'agreement among raft nodes before linearized reading' (duration: 173.656651ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:38:09.695518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.244543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-28T19:38:09.69554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.440657ms","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-07-28T19:38:09.695557Z","caller":"traceutil/trace.go:171","msg":"trace[1823345855] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1294; }","duration":"155.457898ms","start":"2026-07-28T19:38:09.540094Z","end":"2026-07-28T19:38:09.695552Z","steps":["trace[1823345855] 'agreement among raft nodes before linearized reading' (duration: 155.406267ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:38:09.695582Z","caller":"traceutil/trace.go:171","msg":"trace[1269060205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1294; }","duration":"155.354136ms","start":"2026-07-28T19:38:09.540215Z","end":"2026-07-28T19:38:09.695569Z","steps":["trace[1269060205] 'agreement among raft nodes before linearized reading' (duration: 155.174231ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:38:09.93118Z","caller":"traceutil/trace.go:171","msg":"trace[1469031312] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"231.754317ms","start":"2026-07-28T19:38:09.699392Z","end":"2026-07-28T19:38:09.931146Z","steps":["trace[1469031312] 'process raft request' (duration: 210.120949ms)","trace[1469031312] 'compare' (duration: 21.432354ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T19:38:09.974903Z","caller":"traceutil/trace.go:171","msg":"trace[1037075291] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"204.169641ms","start":"2026-07-28T19:38:09.770705Z","end":"2026-07-28T19:38:09.974875Z","steps":["trace[1037075291] 'process raft request' (duration: 204.099139ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:38:09.975246Z","caller":"traceutil/trace.go:171","msg":"trace[375556641] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"274.233834ms","start":"2026-07-28T19:38:09.701001Z","end":"2026-07-28T19:38:09.975235Z","steps":["trace[375556641] 'process raft request' (duration: 273.759682ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:38:09.975301Z","caller":"traceutil/trace.go:171","msg":"trace[1221067922] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"275.265429ms","start":"2026-07-28T19:38:09.699989Z","end":"2026-07-28T19:38:09.975255Z","steps":["trace[1221067922] 'process raft request' (duration: 274.731616ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:38:09.97565Z","caller":"traceutil/trace.go:171","msg":"trace[497065765] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"275.955498ms","start":"2026-07-28T19:38:09.699684Z","end":"2026-07-28T19:38:09.975639Z","steps":["trace[497065765] 'process raft request' (duration: 274.893501ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:38:10.129499Z","caller":"traceutil/trace.go:171","msg":"trace[2137628194] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"125.069812ms","start":"2026-07-28T19:38:10.004396Z","end":"2026-07-28T19:38:10.129465Z","steps":["trace[2137628194] 'process raft request' (duration: 103.762042ms)","trace[2137628194] 'compare' (duration: 20.993432ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T19:38:19.792277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.188734ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T19:38:19.792429Z","caller":"traceutil/trace.go:171","msg":"trace[1851526965] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1367; }","duration":"391.346847ms","start":"2026-07-28T19:38:19.401052Z","end":"2026-07-28T19:38:19.792398Z","steps":["trace[1851526965] 'range keys from in-memory index tree' (duration: 391.171333ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:38:20.320096Z","caller":"traceutil/trace.go:171","msg":"trace[474773648] linearizableReadLoop","detail":"{readStateIndex:1418; appliedIndex:1417; }","duration":"342.087331ms","start":"2026-07-28T19:38:19.977984Z","end":"2026-07-28T19:38:20.320071Z","steps":["trace[474773648] 'read index received' (duration: 341.925388ms)","trace[474773648] 'applied index is now lower than readState.Index' (duration: 160.553µs)"],"step_count":2} {"level":"info","ts":"2026-07-28T19:38:20.320215Z","caller":"traceutil/trace.go:171","msg":"trace[1472473979] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"522.791197ms","start":"2026-07-28T19:38:19.797391Z","end":"2026-07-28T19:38:20.320182Z","steps":["trace[1472473979] 'process raft request' (duration: 522.51067ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:38:20.320655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:38:19.797371Z","time spent":"523.059604ms","remote":"127.0.0.1:35548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-28T19:38:20.32101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.017084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-28T19:38:20.321066Z","caller":"traceutil/trace.go:171","msg":"trace[1702593850] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1368; }","duration":"343.142099ms","start":"2026-07-28T19:38:19.97791Z","end":"2026-07-28T19:38:20.321052Z","steps":["trace[1702593850] 'agreement among raft nodes before linearized reading' (duration: 342.272186ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:38:20.321436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:38:19.977887Z","time spent":"343.419685ms","remote":"127.0.0.1:35548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-28T19:38:20.378343Z","caller":"traceutil/trace.go:171","msg":"trace[1754367470] transaction","detail":"{read_only:false; response_revision:1369; number_of_response:1; }","duration":"201.838442ms","start":"2026-07-28T19:38:20.176476Z","end":"2026-07-28T19:38:20.378314Z","steps":["trace[1754367470] 'process raft request' (duration: 201.589266ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T19:38:20.469612Z","caller":"traceutil/trace.go:171","msg":"trace[2022243077] linearizableReadLoop","detail":"{readStateIndex:1420; appliedIndex:1418; }","duration":"149.433229ms","start":"2026-07-28T19:38:20.320161Z","end":"2026-07-28T19:38:20.469595Z","steps":["trace[2022243077] 'read index received' (duration: 57.932622ms)","trace[2022243077] 'applied index is now lower than readState.Index' (duration: 91.499317ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T19:38:20.469834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.399379ms","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-07-28T19:38:20.469856Z","caller":"traceutil/trace.go:171","msg":"trace[1916923353] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1369; }","duration":"428.472071ms","start":"2026-07-28T19:38:20.041379Z","end":"2026-07-28T19:38:20.469851Z","steps":["trace[1916923353] 'agreement among raft nodes before linearized reading' (duration: 428.351908ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:38:20.469891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:38:20.041358Z","time spent":"428.528423ms","remote":"127.0.0.1:35548","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":"warn","ts":"2026-07-28T19:38:20.47012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.518842ms","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-07-28T19:38:20.470108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.798445ms","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-07-28T19:38:20.470159Z","caller":"traceutil/trace.go:171","msg":"trace[1242111588] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1369; }","duration":"432.583484ms","start":"2026-07-28T19:38:20.037557Z","end":"2026-07-28T19:38:20.470141Z","steps":["trace[1242111588] 'agreement among raft nodes before linearized reading' (duration: 432.42247ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:38:20.470176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:38:20.037543Z","time spent":"432.629245ms","remote":"127.0.0.1:35548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-28T19:38:20.47017Z","caller":"traceutil/trace.go:171","msg":"trace[1866501518] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1369; }","duration":"429.879196ms","start":"2026-07-28T19:38:20.040276Z","end":"2026-07-28T19:38:20.470156Z","steps":["trace[1866501518] 'agreement among raft nodes before linearized reading' (duration: 429.665291ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:38:20.470207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:38:20.040217Z","time spent":"429.98449ms","remote":"127.0.0.1:35548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-28T19:38:20.470292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.769743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T19:38:20.47053Z","caller":"traceutil/trace.go:171","msg":"trace[2140227993] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1369; }","duration":"471.175193ms","start":"2026-07-28T19:38:19.999305Z","end":"2026-07-28T19:38:20.470481Z","steps":["trace[2140227993] 'agreement among raft nodes before linearized reading' (duration: 470.505757ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:38:20.47063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T19:38:19.999284Z","time spent":"471.327477ms","remote":"127.0.0.1:35726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"info","ts":"2026-07-28T19:38:20.470342Z","caller":"traceutil/trace.go:171","msg":"trace[93521014] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"144.446575ms","start":"2026-07-28T19:38:20.325887Z","end":"2026-07-28T19:38:20.470334Z","steps":["trace[93521014] 'process raft request' (duration: 143.623015ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:38:20.472163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.34112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-07-28T19:38:20.47221Z","caller":"traceutil/trace.go:171","msg":"trace[625196824] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1370; }","duration":"144.445833ms","start":"2026-07-28T19:38:20.327752Z","end":"2026-07-28T19:38:20.472198Z","steps":["trace[625196824] 'agreement among raft nodes before linearized reading' (duration: 142.574858ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T19:38:20.472236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.819779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T19:38:20.472384Z","caller":"traceutil/trace.go:171","msg":"trace[611397213] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1370; }","duration":"138.001725ms","start":"2026-07-28T19:38:20.334365Z","end":"2026-07-28T19:38:20.472367Z","steps":["trace[611397213] 'agreement among raft nodes before linearized reading' (duration: 135.971874ms)"],"step_count":1}