{"level":"warn","ts":"2026-07-24T17:20:50.795392Z","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-24T17:20:50.795508Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.235: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.235:2380","--initial-cluster=instance=https://199.204.45.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.235: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-24T17:20:50.795586Z","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-24T17:20:50.795597Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-07-24T17:20:50.795621Z","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-24T17:20:50.796286Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"]} {"level":"info","ts":"2026-07-24T17:20:50.796396Z","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.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.235: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-24T17:20:50.800617Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.980116ms"} {"level":"info","ts":"2026-07-24T17:20:50.810344Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"aab6040abcf11","cluster-id":"2bae7d3d8857c059"} {"level":"info","ts":"2026-07-24T17:20:50.810415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=()"} {"level":"info","ts":"2026-07-24T17:20:50.81044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 0"} {"level":"info","ts":"2026-07-24T17:20:50.810453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft aab6040abcf11 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-24T17:20:50.810465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 1"} {"level":"info","ts":"2026-07-24T17:20:50.811627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"warn","ts":"2026-07-24T17:20:50.822054Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-24T17:20:50.82402Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-24T17:20:50.825346Z","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-24T17:20:50.82906Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"aab6040abcf11","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-24T17:20:50.829671Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"aab6040abcf11","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-24T17:20:50.829781Z","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-24T17:20:50.829855Z","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-24T17:20:50.829865Z","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-24T17:20:50.83391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"info","ts":"2026-07-24T17:20:50.834122Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","added-peer-id":"aab6040abcf11","added-peer-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-07-24T17:20:50.834588Z","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-24T17:20:50.834722Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-07-24T17:20:50.834809Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-07-24T17:20:50.834869Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"aab6040abcf11","initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-24T17:20:50.834915Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-24T17:20:51.012464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 is starting a new election at term 1"} {"level":"info","ts":"2026-07-24T17:20:51.012539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-24T17:20:51.01258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgPreVoteResp from aab6040abcf11 at term 1"} {"level":"info","ts":"2026-07-24T17:20:51.012715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became candidate at term 2"} {"level":"info","ts":"2026-07-24T17:20:51.012733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgVoteResp from aab6040abcf11 at term 2"} {"level":"info","ts":"2026-07-24T17:20:51.012744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became leader at term 2"} {"level":"info","ts":"2026-07-24T17:20:51.012814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: aab6040abcf11 elected leader aab6040abcf11 at term 2"} {"level":"info","ts":"2026-07-24T17:20:51.013902Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-24T17:20:51.01484Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-24T17:20:51.014837Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"aab6040abcf11","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.235:2379]}","request-path":"/0/members/aab6040abcf11/attributes","cluster-id":"2bae7d3d8857c059","publish-timeout":"7s"} {"level":"info","ts":"2026-07-24T17:20:51.015334Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-24T17:20:51.015616Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-24T17:20:51.01567Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-24T17:20:51.01684Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","cluster-version":"3.5"} {"level":"info","ts":"2026-07-24T17:20:51.017003Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-24T17:20:51.017034Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-24T17:20:51.018708Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.235:2379"} {"level":"info","ts":"2026-07-24T17:20:51.026623Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-24T17:21:08.263974Z","caller":"traceutil/trace.go:171","msg":"trace[1298300362] linearizableReadLoop","detail":"{readStateIndex:427; appliedIndex:426; }","duration":"156.786271ms","start":"2026-07-24T17:21:08.107171Z","end":"2026-07-24T17:21:08.263957Z","steps":["trace[1298300362] 'read index received' (duration: 156.681697ms)","trace[1298300362] 'applied index is now lower than readState.Index' (duration: 103.864µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:21:08.26402Z","caller":"traceutil/trace.go:171","msg":"trace[610180722] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"183.171435ms","start":"2026-07-24T17:21:08.080827Z","end":"2026-07-24T17:21:08.263998Z","steps":["trace[610180722] 'process raft request' (duration: 183.034551ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:08.264068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.890535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"info","ts":"2026-07-24T17:21:08.264133Z","caller":"traceutil/trace.go:171","msg":"trace[529818554] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:414; }","duration":"157.008588ms","start":"2026-07-24T17:21:08.107118Z","end":"2026-07-24T17:21:08.264127Z","steps":["trace[529818554] 'agreement among raft nodes before linearized reading' (duration: 156.909125ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:21:08.642956Z","caller":"traceutil/trace.go:171","msg":"trace[2140093547] linearizableReadLoop","detail":"{readStateIndex:428; appliedIndex:427; }","duration":"239.189686ms","start":"2026-07-24T17:21:08.403742Z","end":"2026-07-24T17:21:08.642931Z","steps":["trace[2140093547] 'read index received' (duration: 234.417782ms)","trace[2140093547] 'applied index is now lower than readState.Index' (duration: 4.770764ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:21:08.643075Z","caller":"traceutil/trace.go:171","msg":"trace[846452239] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"370.790052ms","start":"2026-07-24T17:21:08.272276Z","end":"2026-07-24T17:21:08.643066Z","steps":["trace[846452239] 'process raft request' (duration: 365.937915ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:08.64334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.569798ms","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-24T17:21:08.643423Z","caller":"traceutil/trace.go:171","msg":"trace[620714273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:415; }","duration":"239.711842ms","start":"2026-07-24T17:21:08.403692Z","end":"2026-07-24T17:21:08.643403Z","steps":["trace[620714273] 'agreement among raft nodes before linearized reading' (duration: 239.538427ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:08.643473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:21:08.27225Z","time spent":"370.849995ms","remote":"127.0.0.1:44228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4311,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:21:08.971045Z","caller":"traceutil/trace.go:171","msg":"trace[697640845] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"323.007487ms","start":"2026-07-24T17:21:08.647994Z","end":"2026-07-24T17:21:08.971002Z","steps":["trace[697640845] 'process raft request' (duration: 322.793411ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:08.97123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:21:08.647982Z","time spent":"323.157822ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:21:08.971213Z","caller":"traceutil/trace.go:171","msg":"trace[374220870] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"317.861491ms","start":"2026-07-24T17:21:08.653316Z","end":"2026-07-24T17:21:08.971178Z","steps":["trace[374220870] 'process raft request' (duration: 317.622323ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:08.97144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:21:08.653307Z","time spent":"318.015666ms","remote":"127.0.0.1:44228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4119,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:21:34.198358Z","caller":"traceutil/trace.go:171","msg":"trace[1305864129] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"151.149833ms","start":"2026-07-24T17:21:34.047173Z","end":"2026-07-24T17:21:34.198323Z","steps":["trace[1305864129] 'process raft request' (duration: 150.618476ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:21:34.373669Z","caller":"traceutil/trace.go:171","msg":"trace[1418815072] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"162.001713ms","start":"2026-07-24T17:21:34.211636Z","end":"2026-07-24T17:21:34.373638Z","steps":["trace[1418815072] 'process raft request' (duration: 161.798006ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:34.928112Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920882503373062276,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-24T17:21:35.419503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.631484ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-24T17:21:35.419741Z","caller":"traceutil/trace.go:171","msg":"trace[1458732657] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:655; }","duration":"992.672026ms","start":"2026-07-24T17:21:34.427051Z","end":"2026-07-24T17:21:35.419723Z","steps":["trace[1458732657] 'read index received' (duration: 535.533685ms)","trace[1458732657] 'applied index is now lower than readState.Index' (duration: 457.137311ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:21:35.419827Z","caller":"traceutil/trace.go:171","msg":"trace[1480242254] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"1.188533574s","start":"2026-07-24T17:21:34.231258Z","end":"2026-07-24T17:21:35.419792Z","steps":["trace[1480242254] 'process raft request' (duration: 731.365522ms)","trace[1480242254] 'compare' (duration: 456.445359ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:21:35.419826Z","caller":"traceutil/trace.go:171","msg":"trace[813125798] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"1.165806989s","start":"2026-07-24T17:21:34.253988Z","end":"2026-07-24T17:21:35.419795Z","steps":["trace[813125798] 'process raft request' (duration: 1.165669105s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:35.419902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.369194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:21:35.419961Z","caller":"traceutil/trace.go:171","msg":"trace[1969061135] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"598.481497ms","start":"2026-07-24T17:21:34.821461Z","end":"2026-07-24T17:21:35.419942Z","steps":["trace[1969061135] 'agreement among raft nodes before linearized reading' (duration: 598.369014ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:35.419962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"992.900144ms","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-24T17:21:35.41997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:21:34.231233Z","time spent":"1.188660189s","remote":"127.0.0.1:44086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:21:35.419981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.050276ms","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-24T17:21:35.419996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:21:34.821436Z","time spent":"598.55388ms","remote":"127.0.0.1:44050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-24T17:21:35.419985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:21:34.253969Z","time spent":"1.165931244s","remote":"127.0.0.1:44538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-24T17:21:35.420016Z","caller":"traceutil/trace.go:171","msg":"trace[1846314623] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:635; }","duration":"992.992597ms","start":"2026-07-24T17:21:34.427006Z","end":"2026-07-24T17:21:35.419999Z","steps":["trace[1846314623] 'agreement among raft nodes before linearized reading' (duration: 992.78039ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:21:35.420019Z","caller":"traceutil/trace.go:171","msg":"trace[576047811] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:635; }","duration":"241.126838ms","start":"2026-07-24T17:21:35.178882Z","end":"2026-07-24T17:21:35.420009Z","steps":["trace[576047811] 'agreement among raft nodes before linearized reading' (duration: 240.944492ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:35.420028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.089196ms","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-24T17:21:35.420051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:21:34.426984Z","time spent":"993.05985ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-24T17:21:35.420047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.56752ms","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-24T17:21:35.420084Z","caller":"traceutil/trace.go:171","msg":"trace[1217032435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:635; }","duration":"586.186669ms","start":"2026-07-24T17:21:34.833878Z","end":"2026-07-24T17:21:35.420065Z","steps":["trace[1217032435] 'agreement among raft nodes before linearized reading' (duration: 585.981293ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:35.420127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:21:34.833671Z","time spent":"586.448648ms","remote":"127.0.0.1:44306","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-07-24T17:21:35.420164Z","caller":"traceutil/trace.go:171","msg":"trace[255086366] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:635; }","duration":"237.695224ms","start":"2026-07-24T17:21:35.182413Z","end":"2026-07-24T17:21:35.420108Z","steps":["trace[255086366] 'agreement among raft nodes before linearized reading' (duration: 237.430025ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:36.435491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.340407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:21:36.435546Z","caller":"traceutil/trace.go:171","msg":"trace[790709879] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:639; }","duration":"612.43976ms","start":"2026-07-24T17:21:35.823093Z","end":"2026-07-24T17:21:36.435533Z","steps":["trace[790709879] 'range keys from in-memory index tree' (duration: 612.218882ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:36.435569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:21:35.823071Z","time spent":"612.493862ms","remote":"127.0.0.1:44050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-24T17:21:36.642406Z","caller":"traceutil/trace.go:171","msg":"trace[903788679] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"205.697667ms","start":"2026-07-24T17:21:36.436684Z","end":"2026-07-24T17:21:36.642382Z","steps":["trace[903788679] 'read index received' (duration: 203.318627ms)","trace[903788679] 'applied index is now lower than readState.Index' (duration: 2.37794ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:21:36.642524Z","caller":"traceutil/trace.go:171","msg":"trace[73351431] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"784.791476ms","start":"2026-07-24T17:21:35.857677Z","end":"2026-07-24T17:21:36.642469Z","steps":["trace[73351431] 'process raft request' (duration: 783.139471ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:36.642613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.899073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:21:36.642847Z","caller":"traceutil/trace.go:171","msg":"trace[538924852] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:640; }","duration":"206.179252ms","start":"2026-07-24T17:21:36.436655Z","end":"2026-07-24T17:21:36.642834Z","steps":["trace[538924852] 'agreement among raft nodes before linearized reading' (duration: 205.882393ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:36.64322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:21:35.857637Z","time spent":"785.082887ms","remote":"127.0.0.1:44152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:21:38.572737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.324024ms","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-07-24T17:21:38.572853Z","caller":"traceutil/trace.go:171","msg":"trace[1531972384] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:677; }","duration":"157.461089ms","start":"2026-07-24T17:21:38.41537Z","end":"2026-07-24T17:21:38.572831Z","steps":["trace[1531972384] 'range keys from in-memory index tree' (duration: 157.235451ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:21:46.292491Z","caller":"traceutil/trace.go:171","msg":"trace[1533583093] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"162.820299ms","start":"2026-07-24T17:21:46.129636Z","end":"2026-07-24T17:21:46.292456Z","steps":["trace[1533583093] 'process raft request' (duration: 162.24552ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:21:46.292619Z","caller":"traceutil/trace.go:171","msg":"trace[2145029556] linearizableReadLoop","detail":"{readStateIndex:777; appliedIndex:773; }","duration":"121.437572ms","start":"2026-07-24T17:21:46.171158Z","end":"2026-07-24T17:21:46.292596Z","steps":["trace[2145029556] 'read index received' (duration: 120.716777ms)","trace[2145029556] 'applied index is now lower than readState.Index' (duration: 719.655µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:21:46.292495Z","caller":"traceutil/trace.go:171","msg":"trace[1523324525] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"162.766188ms","start":"2026-07-24T17:21:46.129701Z","end":"2026-07-24T17:21:46.292467Z","steps":["trace[1523324525] 'process raft request' (duration: 162.656934ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:21:46.292739Z","caller":"traceutil/trace.go:171","msg":"trace[901283512] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"160.764821ms","start":"2026-07-24T17:21:46.13196Z","end":"2026-07-24T17:21:46.292725Z","steps":["trace[901283512] 'process raft request' (duration: 160.554783ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:21:46.292853Z","caller":"traceutil/trace.go:171","msg":"trace[289771199] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"161.232116ms","start":"2026-07-24T17:21:46.131588Z","end":"2026-07-24T17:21:46.29282Z","steps":["trace[289771199] 'process raft request' (duration: 160.840842ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:46.292909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.734822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:21:46.292956Z","caller":"traceutil/trace.go:171","msg":"trace[431203085] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:0; response_revision:752; }","duration":"121.831026ms","start":"2026-07-24T17:21:46.171111Z","end":"2026-07-24T17:21:46.292942Z","steps":["trace[431203085] 'agreement among raft nodes before linearized reading' (duration: 121.700231ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:46.292996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.773913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:21:46.293044Z","caller":"traceutil/trace.go:171","msg":"trace[1220686698] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:0; response_revision:752; }","duration":"121.861877ms","start":"2026-07-24T17:21:46.171171Z","end":"2026-07-24T17:21:46.293033Z","steps":["trace[1220686698] 'agreement among raft nodes before linearized reading' (duration: 121.774314ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:21:46.416801Z","caller":"traceutil/trace.go:171","msg":"trace[920604030] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"117.218401ms","start":"2026-07-24T17:21:46.299544Z","end":"2026-07-24T17:21:46.416762Z","steps":["trace[920604030] 'process raft request' (duration: 113.644301ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:21:46.418077Z","caller":"traceutil/trace.go:171","msg":"trace[1665795833] transaction","detail":"{read_only:false; number_of_response:0; response_revision:753; }","duration":"118.519684ms","start":"2026-07-24T17:21:46.299541Z","end":"2026-07-24T17:21:46.418061Z","steps":["trace[1665795833] 'process raft request' (duration: 118.449061ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:54.108831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.213263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:21:54.108919Z","caller":"traceutil/trace.go:171","msg":"trace[222789214] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:803; }","duration":"286.346187ms","start":"2026-07-24T17:21:53.822552Z","end":"2026-07-24T17:21:54.108898Z","steps":["trace[222789214] 'range keys from in-memory index tree' (duration: 286.13418ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:54.108808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.560504ms","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-24T17:21:54.109321Z","caller":"traceutil/trace.go:171","msg":"trace[1381054412] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:803; }","duration":"363.108062ms","start":"2026-07-24T17:21:53.746195Z","end":"2026-07-24T17:21:54.109303Z","steps":["trace[1381054412] 'range keys from in-memory index tree' (duration: 362.525212ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:56.509938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.683267ms","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-24T17:21:56.510025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.933937ms","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-24T17:21:56.510064Z","caller":"traceutil/trace.go:171","msg":"trace[863128424] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:814; }","duration":"172.849272ms","start":"2026-07-24T17:21:56.337182Z","end":"2026-07-24T17:21:56.510031Z","steps":["trace[863128424] 'range keys from in-memory index tree' (duration: 172.511441ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:21:56.51018Z","caller":"traceutil/trace.go:171","msg":"trace[1956472704] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:814; }","duration":"171.119904ms","start":"2026-07-24T17:21:56.339001Z","end":"2026-07-24T17:21:56.510121Z","steps":["trace[1956472704] 'range keys from in-memory index tree' (duration: 170.70261ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:56.510344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.385597ms","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-24T17:21:56.510403Z","caller":"traceutil/trace.go:171","msg":"trace[2029180957] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:814; }","duration":"172.494011ms","start":"2026-07-24T17:21:56.337891Z","end":"2026-07-24T17:21:56.510385Z","steps":["trace[2029180957] 'range keys from in-memory index tree' (duration: 172.143329ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:56.510578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.468047ms","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-24T17:21:56.510705Z","caller":"traceutil/trace.go:171","msg":"trace[2033710786] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:814; }","duration":"174.677414ms","start":"2026-07-24T17:21:56.336001Z","end":"2026-07-24T17:21:56.510679Z","steps":["trace[2033710786] 'range keys from in-memory index tree' (duration: 174.231989ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:21:58.731035Z","caller":"traceutil/trace.go:171","msg":"trace[860939067] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"647.68839ms","start":"2026-07-24T17:21:58.083316Z","end":"2026-07-24T17:21:58.731004Z","steps":["trace[860939067] 'process raft request' (duration: 647.513324ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:58.731217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:21:58.083299Z","time spent":"647.824694ms","remote":"127.0.0.1:44226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5052,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:21:58.735548Z","caller":"traceutil/trace.go:171","msg":"trace[219251122] linearizableReadLoop","detail":"{readStateIndex:851; appliedIndex:849; }","duration":"473.856497ms","start":"2026-07-24T17:21:58.26167Z","end":"2026-07-24T17:21:58.735526Z","steps":["trace[219251122] 'read index received' (duration: 469.125207ms)","trace[219251122] 'applied index is now lower than readState.Index' (duration: 4.73036ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:21:58.735653Z","caller":"traceutil/trace.go:171","msg":"trace[74231022] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"648.62302ms","start":"2026-07-24T17:21:58.087022Z","end":"2026-07-24T17:21:58.735645Z","steps":["trace[74231022] 'process raft request' (duration: 648.372711ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:58.735803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:21:58.086986Z","time spent":"648.691682ms","remote":"127.0.0.1:44228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4216,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:21:58.736313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.639223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-24T17:21:58.736298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.258777ms","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-24T17:21:58.736356Z","caller":"traceutil/trace.go:171","msg":"trace[1694067039] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:822; }","duration":"474.681654ms","start":"2026-07-24T17:21:58.261662Z","end":"2026-07-24T17:21:58.736344Z","steps":["trace[1694067039] 'agreement among raft nodes before linearized reading' (duration: 474.621632ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:21:58.736374Z","caller":"traceutil/trace.go:171","msg":"trace[1167582675] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:822; }","duration":"214.390581ms","start":"2026-07-24T17:21:58.521965Z","end":"2026-07-24T17:21:58.736356Z","steps":["trace[1167582675] 'agreement among raft nodes before linearized reading' (duration: 213.849983ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:58.736679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.979949ms","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-24T17:21:58.736717Z","caller":"traceutil/trace.go:171","msg":"trace[779932963] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:822; }","duration":"214.03233ms","start":"2026-07-24T17:21:58.522678Z","end":"2026-07-24T17:21:58.73671Z","steps":["trace[779932963] 'agreement among raft nodes before linearized reading' (duration: 213.956468ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:21:58.736379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:21:58.261596Z","time spent":"474.777707ms","remote":"127.0.0.1:44472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":28,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-07-24T17:23:07.430208Z","caller":"traceutil/trace.go:171","msg":"trace[1537743996] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"353.965758ms","start":"2026-07-24T17:23:07.076212Z","end":"2026-07-24T17:23:07.430178Z","steps":["trace[1537743996] 'process raft request' (duration: 353.808063ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:23:07.430149Z","caller":"traceutil/trace.go:171","msg":"trace[1876442163] linearizableReadLoop","detail":"{readStateIndex:1218; appliedIndex:1217; }","duration":"353.020265ms","start":"2026-07-24T17:23:07.077109Z","end":"2026-07-24T17:23:07.430129Z","steps":["trace[1876442163] 'read index received' (duration: 352.959213ms)","trace[1876442163] 'applied index is now lower than readState.Index' (duration: 60.352µs)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:23:07.43036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.241003ms","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-24T17:23:07.430404Z","caller":"traceutil/trace.go:171","msg":"trace[751434573] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1174; }","duration":"353.301804ms","start":"2026-07-24T17:23:07.077092Z","end":"2026-07-24T17:23:07.430394Z","steps":["trace[751434573] 'agreement among raft nodes before linearized reading' (duration: 353.16287ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:23:07.43039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:23:07.076198Z","time spent":"354.091743ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:23:07.430427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:23:07.077084Z","time spent":"353.336935ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-24T17:23:07.431213Z","caller":"traceutil/trace.go:171","msg":"trace[1042779301] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"352.155645ms","start":"2026-07-24T17:23:07.079045Z","end":"2026-07-24T17:23:07.431201Z","steps":["trace[1042779301] 'process raft request' (duration: 352.090283ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:23:07.431262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:23:07.079038Z","time spent":"352.201087ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:23:07.431385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.671744ms","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-24T17:23:07.431411Z","caller":"traceutil/trace.go:171","msg":"trace[1639978044] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1176; }","duration":"348.714046ms","start":"2026-07-24T17:23:07.082689Z","end":"2026-07-24T17:23:07.431403Z","steps":["trace[1639978044] 'agreement among raft nodes before linearized reading' (duration: 348.628453ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:23:07.431416Z","caller":"traceutil/trace.go:171","msg":"trace[1809335281] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"299.186864ms","start":"2026-07-24T17:23:07.132221Z","end":"2026-07-24T17:23:07.431408Z","steps":["trace[1809335281] 'process raft request' (duration: 298.955936ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:23:07.431431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:23:07.082683Z","time spent":"348.743487ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-24T17:23:07.431531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.886687ms","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-24T17:23:07.43155Z","caller":"traceutil/trace.go:171","msg":"trace[1632973822] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1176; }","duration":"347.905348ms","start":"2026-07-24T17:23:07.083637Z","end":"2026-07-24T17:23:07.431543Z","steps":["trace[1632973822] 'agreement among raft nodes before linearized reading' (duration: 347.852716ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:23:07.431565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:23:07.083597Z","time spent":"347.96424ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":511,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-24T17:23:09.938303Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920882503373063457,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-24T17:23:10.257568Z","caller":"traceutil/trace.go:171","msg":"trace[1048950169] linearizableReadLoop","detail":"{readStateIndex:1226; appliedIndex:1224; }","duration":"820.029824ms","start":"2026-07-24T17:23:09.437495Z","end":"2026-07-24T17:23:10.257524Z","steps":["trace[1048950169] 'read index received' (duration: 812.590556ms)","trace[1048950169] 'applied index is now lower than readState.Index' (duration: 7.437988ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:23:10.257928Z","caller":"traceutil/trace.go:171","msg":"trace[1644850510] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"820.319953ms","start":"2026-07-24T17:23:09.437597Z","end":"2026-07-24T17:23:10.257917Z","steps":["trace[1644850510] 'process raft request' (duration: 819.756134ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:23:10.258054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:23:09.437578Z","time spent":"820.383036ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:23:10.258546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"821.049438ms","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-24T17:23:10.258583Z","caller":"traceutil/trace.go:171","msg":"trace[961513506] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1181; }","duration":"821.119631ms","start":"2026-07-24T17:23:09.437455Z","end":"2026-07-24T17:23:10.258575Z","steps":["trace[961513506] 'agreement among raft nodes before linearized reading' (duration: 820.972216ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:23:10.258613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:23:09.437427Z","time spent":"821.179703ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":525,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-24T17:23:10.258772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"821.095ms","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-07-24T17:23:10.258791Z","caller":"traceutil/trace.go:171","msg":"trace[424530815] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1181; }","duration":"821.114331ms","start":"2026-07-24T17:23:09.43767Z","end":"2026-07-24T17:23:10.258785Z","steps":["trace[424530815] 'agreement among raft nodes before linearized reading' (duration: 821.055829ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:23:10.25882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:23:09.437652Z","time spent":"821.162412ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-24T17:23:10.259184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.09001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:23:10.259213Z","caller":"traceutil/trace.go:171","msg":"trace[1292926139] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1181; }","duration":"374.152132ms","start":"2026-07-24T17:23:09.885054Z","end":"2026-07-24T17:23:10.259206Z","steps":["trace[1292926139] 'agreement among raft nodes before linearized reading' (duration: 374.104881ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:23:10.259231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:23:09.88502Z","time spent":"374.207135ms","remote":"127.0.0.1:44050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-24T17:23:10.25939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.551759ms","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-24T17:23:10.259408Z","caller":"traceutil/trace.go:171","msg":"trace[1092344784] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1181; }","duration":"815.587471ms","start":"2026-07-24T17:23:09.443815Z","end":"2026-07-24T17:23:10.259402Z","steps":["trace[1092344784] 'agreement among raft nodes before linearized reading' (duration: 815.530939ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:23:10.259425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:23:09.443805Z","time spent":"815.616082ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-24T17:23:10.259538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"818.510481ms","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-24T17:23:10.259558Z","caller":"traceutil/trace.go:171","msg":"trace[1615514109] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1181; }","duration":"818.75175ms","start":"2026-07-24T17:23:09.440799Z","end":"2026-07-24T17:23:10.259551Z","steps":["trace[1615514109] 'agreement among raft nodes before linearized reading' (duration: 818.694778ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:23:10.259574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:23:09.440768Z","time spent":"818.801332ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-24T17:24:06.720287Z","caller":"traceutil/trace.go:171","msg":"trace[492585460] linearizableReadLoop","detail":"{readStateIndex:1465; appliedIndex:1464; }","duration":"195.846187ms","start":"2026-07-24T17:24:06.524414Z","end":"2026-07-24T17:24:06.72026Z","steps":["trace[492585460] 'read index received' (duration: 195.736847ms)","trace[492585460] 'applied index is now lower than readState.Index' (duration: 108.24µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:06.720367Z","caller":"traceutil/trace.go:171","msg":"trace[622914126] transaction","detail":"{read_only:false; response_revision:1408; number_of_response:1; }","duration":"198.093991ms","start":"2026-07-24T17:24:06.522245Z","end":"2026-07-24T17:24:06.720339Z","steps":["trace[622914126] 'process raft request' (duration: 197.88417ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:06.720469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.031909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:generic-garbage-collector\" ","response":"range_response_count:1 size:775"} {"level":"info","ts":"2026-07-24T17:24:06.720527Z","caller":"traceutil/trace.go:171","msg":"trace[502023237] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:generic-garbage-collector; range_end:; response_count:1; response_revision:1408; }","duration":"196.135759ms","start":"2026-07-24T17:24:06.524375Z","end":"2026-07-24T17:24:06.72051Z","steps":["trace[502023237] 'agreement among raft nodes before linearized reading' (duration: 196.022228ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:06.841527Z","caller":"traceutil/trace.go:171","msg":"trace[2005470866] linearizableReadLoop","detail":"{readStateIndex:1466; appliedIndex:1465; }","duration":"121.138776ms","start":"2026-07-24T17:24:06.720372Z","end":"2026-07-24T17:24:06.84151Z","steps":["trace[2005470866] 'read index received' (duration: 80.20437ms)","trace[2005470866] 'applied index is now lower than readState.Index' (duration: 40.933395ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:06.841691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.966142ms","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-24T17:24:06.841716Z","caller":"traceutil/trace.go:171","msg":"trace[65759881] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1409; }","duration":"201.029382ms","start":"2026-07-24T17:24:06.640681Z","end":"2026-07-24T17:24:06.841711Z","steps":["trace[65759881] 'agreement among raft nodes before linearized reading' (duration: 200.930701ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:06.841784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.982718ms","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-24T17:24:06.841822Z","caller":"traceutil/trace.go:171","msg":"trace[1305564240] transaction","detail":"{read_only:false; response_revision:1409; number_of_response:1; }","duration":"252.162235ms","start":"2026-07-24T17:24:06.589633Z","end":"2026-07-24T17:24:06.841795Z","steps":["trace[1305564240] 'process raft request' (duration: 211.022678ms)","trace[1305564240] 'compare' (duration: 40.754855ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:06.841887Z","caller":"traceutil/trace.go:171","msg":"trace[1193400056] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1409; }","duration":"181.136549ms","start":"2026-07-24T17:24:06.660717Z","end":"2026-07-24T17:24:06.841853Z","steps":["trace[1193400056] 'agreement among raft nodes before linearized reading' (duration: 180.852987ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:06.841912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.86437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:kube-dns\" ","response":"range_response_count:1 size:578"} {"level":"info","ts":"2026-07-24T17:24:06.841949Z","caller":"traceutil/trace.go:171","msg":"trace[1318882301] range","detail":"{range_begin:/registry/clusterroles/system:kube-dns; range_end:; response_count:1; response_revision:1409; }","duration":"307.929281ms","start":"2026-07-24T17:24:06.534009Z","end":"2026-07-24T17:24:06.841938Z","steps":["trace[1318882301] 'agreement among raft nodes before linearized reading' (duration: 307.844591ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:06.841974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:06.533998Z","time spent":"307.969811ms","remote":"127.0.0.1:44406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":599,"request content":"key:\"/registry/clusterroles/system:kube-dns\" "} {"level":"warn","ts":"2026-07-24T17:24:06.842207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.739779ms","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-24T17:24:06.84224Z","caller":"traceutil/trace.go:171","msg":"trace[2137309180] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1409; }","duration":"243.817329ms","start":"2026-07-24T17:24:06.598412Z","end":"2026-07-24T17:24:06.842229Z","steps":["trace[2137309180] 'agreement among raft nodes before linearized reading' (duration: 243.667608ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:06.842242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.073197ms","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-24T17:24:06.842269Z","caller":"traceutil/trace.go:171","msg":"trace[581461646] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1409; }","duration":"221.130027ms","start":"2026-07-24T17:24:06.621132Z","end":"2026-07-24T17:24:06.842262Z","steps":["trace[581461646] 'agreement among raft nodes before linearized reading' (duration: 221.053987ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:06.842332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.310835ms","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-24T17:24:06.842388Z","caller":"traceutil/trace.go:171","msg":"trace[521413978] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1409; }","duration":"158.394395ms","start":"2026-07-24T17:24:06.683978Z","end":"2026-07-24T17:24:06.842372Z","steps":["trace[521413978] 'agreement among raft nodes before linearized reading' (duration: 158.244324ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:07.117218Z","caller":"traceutil/trace.go:171","msg":"trace[1088260348] transaction","detail":"{read_only:false; response_revision:1412; number_of_response:1; }","duration":"270.012058ms","start":"2026-07-24T17:24:06.84717Z","end":"2026-07-24T17:24:07.117182Z","steps":["trace[1088260348] 'process raft request' (duration: 194.286244ms)","trace[1088260348] 'compare' (duration: 75.506312ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:07.117475Z","caller":"traceutil/trace.go:171","msg":"trace[229094999] transaction","detail":"{read_only:false; response_revision:1413; number_of_response:1; }","duration":"270.230859ms","start":"2026-07-24T17:24:06.847195Z","end":"2026-07-24T17:24:07.117426Z","steps":["trace[229094999] 'process raft request' (duration: 269.929937ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:07.117518Z","caller":"traceutil/trace.go:171","msg":"trace[1325305963] linearizableReadLoop","detail":"{readStateIndex:1471; appliedIndex:1468; }","duration":"203.744103ms","start":"2026-07-24T17:24:06.91375Z","end":"2026-07-24T17:24:07.117494Z","steps":["trace[1325305963] 'read index received' (duration: 127.632966ms)","trace[1325305963] 'applied index is now lower than readState.Index' (duration: 76.110267ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:07.117663Z","caller":"traceutil/trace.go:171","msg":"trace[1116399914] transaction","detail":"{read_only:false; response_revision:1414; number_of_response:1; }","duration":"270.368601ms","start":"2026-07-24T17:24:06.847283Z","end":"2026-07-24T17:24:07.117651Z","steps":["trace[1116399914] 'process raft request' (duration: 270.096409ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:07.117763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.994624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:775"} {"level":"warn","ts":"2026-07-24T17:24:07.117771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.318775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:kube-scheduler\" ","response":"range_response_count:1 size:1383"} {"level":"info","ts":"2026-07-24T17:24:07.117821Z","caller":"traceutil/trace.go:171","msg":"trace[1394785385] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:1414; }","duration":"204.096026ms","start":"2026-07-24T17:24:06.913707Z","end":"2026-07-24T17:24:07.117803Z","steps":["trace[1394785385] 'agreement among raft nodes before linearized reading' (duration: 203.982285ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:07.117833Z","caller":"traceutil/trace.go:171","msg":"trace[1403553145] range","detail":"{range_begin:/registry/clusterroles/system:kube-scheduler; range_end:; response_count:1; response_revision:1414; }","duration":"183.424126ms","start":"2026-07-24T17:24:06.93439Z","end":"2026-07-24T17:24:07.117814Z","steps":["trace[1403553145] 'agreement among raft nodes before linearized reading' (duration: 183.296385ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:09.321115Z","caller":"traceutil/trace.go:171","msg":"trace[1837706768] transaction","detail":"{read_only:false; response_revision:1418; number_of_response:1; }","duration":"158.644218ms","start":"2026-07-24T17:24:09.162448Z","end":"2026-07-24T17:24:09.321092Z","steps":["trace[1837706768] 'process raft request' (duration: 158.479117ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:09.789987Z","caller":"traceutil/trace.go:171","msg":"trace[585962567] transaction","detail":"{read_only:false; response_revision:1420; number_of_response:1; }","duration":"627.161369ms","start":"2026-07-24T17:24:09.162807Z","end":"2026-07-24T17:24:09.789969Z","steps":["trace[585962567] 'process raft request' (duration: 627.116988ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:09.790049Z","caller":"traceutil/trace.go:171","msg":"trace[214898834] transaction","detail":"{read_only:false; response_revision:1419; number_of_response:1; }","duration":"627.34812ms","start":"2026-07-24T17:24:09.162676Z","end":"2026-07-24T17:24:09.790024Z","steps":["trace[214898834] 'process raft request' (duration: 627.135469ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:09.790301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:09.162802Z","time spent":"627.29196ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:24:09.790479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:09.162656Z","time spent":"627.600842ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:24:09.898894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.916886ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:26"} {"level":"info","ts":"2026-07-24T17:24:09.89903Z","caller":"traceutil/trace.go:171","msg":"trace[1685114656] linearizableReadLoop","detail":"{readStateIndex:1476; appliedIndex:1474; }","duration":"736.254925ms","start":"2026-07-24T17:24:09.162746Z","end":"2026-07-24T17:24:09.899001Z","steps":["trace[1685114656] 'read index received' (duration: 158.259646ms)","trace[1685114656] 'applied index is now lower than readState.Index' (duration: 577.993409ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:09.89922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.430806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:service-account-controller\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-07-24T17:24:09.89932Z","caller":"traceutil/trace.go:171","msg":"trace[1406147178] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:service-account-controller; range_end:; response_count:1; response_revision:1420; }","duration":"736.561777ms","start":"2026-07-24T17:24:09.162732Z","end":"2026-07-24T17:24:09.899293Z","steps":["trace[1406147178] 'agreement among raft nodes before linearized reading' (duration: 736.351895ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:09.899374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:09.162725Z","time spent":"736.639977ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":800,"request content":"key:\"/registry/clusterrolebindings/system:controller:service-account-controller\" "} {"level":"warn","ts":"2026-07-24T17:24:09.899243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.053341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:service-controller\" ","response":"range_response_count:1 size:747"} {"level":"info","ts":"2026-07-24T17:24:09.899574Z","caller":"traceutil/trace.go:171","msg":"trace[97112697] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:service-controller; range_end:; response_count:1; response_revision:1420; }","duration":"670.424894ms","start":"2026-07-24T17:24:09.229129Z","end":"2026-07-24T17:24:09.899553Z","steps":["trace[97112697] 'agreement among raft nodes before linearized reading' (duration: 670.023721ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:09.899659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:09.22911Z","time spent":"670.511314ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":1,"response size":768,"request content":"key:\"/registry/clusterrolebindings/system:controller:service-controller\" "} {"level":"info","ts":"2026-07-24T17:24:13.522084Z","caller":"traceutil/trace.go:171","msg":"trace[875507623] linearizableReadLoop","detail":"{readStateIndex:1489; appliedIndex:1488; }","duration":"124.811373ms","start":"2026-07-24T17:24:13.397244Z","end":"2026-07-24T17:24:13.522056Z","steps":["trace[875507623] 'read index received' (duration: 124.518071ms)","trace[875507623] 'applied index is now lower than readState.Index' (duration: 291.842µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:13.522272Z","caller":"traceutil/trace.go:171","msg":"trace[531074374] transaction","detail":"{read_only:false; response_revision:1431; number_of_response:1; }","duration":"142.97714ms","start":"2026-07-24T17:24:13.37924Z","end":"2026-07-24T17:24:13.522217Z","steps":["trace[531074374] 'process raft request' (duration: 142.629018ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:13.522406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.120546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/envoy-gateway-system/\" range_end:\"/registry/deployments/envoy-gateway-system0\" limit:500 ","response":"range_response_count:1 size:5641"} {"level":"warn","ts":"2026-07-24T17:24:13.522416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.07818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/default/\" range_end:\"/registry/deployments/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:24:13.522488Z","caller":"traceutil/trace.go:171","msg":"trace[1840869388] range","detail":"{range_begin:/registry/deployments/envoy-gateway-system/; range_end:/registry/deployments/envoy-gateway-system0; response_count:1; response_revision:1431; }","duration":"125.257627ms","start":"2026-07-24T17:24:13.397211Z","end":"2026-07-24T17:24:13.522469Z","steps":["trace[1840869388] 'agreement among raft nodes before linearized reading' (duration: 124.998575ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:13.522512Z","caller":"traceutil/trace.go:171","msg":"trace[1238158234] range","detail":"{range_begin:/registry/deployments/default/; range_end:/registry/deployments/default0; response_count:0; response_revision:1431; }","duration":"123.208841ms","start":"2026-07-24T17:24:13.399277Z","end":"2026-07-24T17:24:13.522485Z","steps":["trace[1238158234] 'agreement among raft nodes before linearized reading' (duration: 123.033449ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:13.522525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.731951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/envoy-gateway-system/kube-root-ca.crt\" ","response":"range_response_count:1 size:1764"} {"level":"info","ts":"2026-07-24T17:24:13.522592Z","caller":"traceutil/trace.go:171","msg":"trace[911477995] range","detail":"{range_begin:/registry/configmaps/envoy-gateway-system/kube-root-ca.crt; range_end:; response_count:1; response_revision:1431; }","duration":"115.824742ms","start":"2026-07-24T17:24:13.406752Z","end":"2026-07-24T17:24:13.522577Z","steps":["trace[911477995] 'agreement among raft nodes before linearized reading' (duration: 115.65097ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:15.140645Z","caller":"traceutil/trace.go:171","msg":"trace[1519952150] linearizableReadLoop","detail":"{readStateIndex:1494; appliedIndex:1493; }","duration":"143.636617ms","start":"2026-07-24T17:24:14.996987Z","end":"2026-07-24T17:24:15.140624Z","steps":["trace[1519952150] 'read index received' (duration: 143.403115ms)","trace[1519952150] 'applied index is now lower than readState.Index' (duration: 232.402µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:15.140755Z","caller":"traceutil/trace.go:171","msg":"trace[1348223581] transaction","detail":"{read_only:false; response_revision:1435; number_of_response:1; }","duration":"154.275095ms","start":"2026-07-24T17:24:14.986463Z","end":"2026-07-24T17:24:15.140738Z","steps":["trace[1348223581] 'process raft request' (duration: 153.983542ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:15.140909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.897969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-oidc-hmac\" ","response":"range_response_count:1 size:452"} {"level":"info","ts":"2026-07-24T17:24:15.140967Z","caller":"traceutil/trace.go:171","msg":"trace[1322176546] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-oidc-hmac; range_end:; response_count:1; response_revision:1435; }","duration":"143.999499ms","start":"2026-07-24T17:24:14.996954Z","end":"2026-07-24T17:24:15.140953Z","steps":["trace[1322176546] 'agreement among raft nodes before linearized reading' (duration: 143.804698ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:15.141061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.70355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/kube-node-lease/\" range_end:\"/registry/cronjobs/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:24:15.141131Z","caller":"traceutil/trace.go:171","msg":"trace[1931593656] range","detail":"{range_begin:/registry/cronjobs/kube-node-lease/; range_end:/registry/cronjobs/kube-node-lease0; response_count:0; response_revision:1435; }","duration":"104.840752ms","start":"2026-07-24T17:24:15.036273Z","end":"2026-07-24T17:24:15.141114Z","steps":["trace[1931593656] 'agreement among raft nodes before linearized reading' (duration: 104.66129ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:15.141138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.842072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-rate-limit\" ","response":"range_response_count:1 size:4452"} {"level":"info","ts":"2026-07-24T17:24:15.14122Z","caller":"traceutil/trace.go:171","msg":"trace[333206260] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-rate-limit; range_end:; response_count:1; response_revision:1435; }","duration":"110.969013ms","start":"2026-07-24T17:24:15.03023Z","end":"2026-07-24T17:24:15.141199Z","steps":["trace[333206260] 'agreement among raft nodes before linearized reading' (duration: 110.750111ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:15.141369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.161292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/default/\" range_end:\"/registry/statefulsets/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:24:15.141617Z","caller":"traceutil/trace.go:171","msg":"trace[1369705353] range","detail":"{range_begin:/registry/statefulsets/default/; range_end:/registry/statefulsets/default0; response_count:0; response_revision:1435; }","duration":"138.889697ms","start":"2026-07-24T17:24:15.002699Z","end":"2026-07-24T17:24:15.141588Z","steps":["trace[1369705353] 'agreement among raft nodes before linearized reading' (duration: 138.131391ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:15.256071Z","caller":"traceutil/trace.go:171","msg":"trace[847498134] transaction","detail":"{read_only:false; response_revision:1437; number_of_response:1; }","duration":"110.58873ms","start":"2026-07-24T17:24:15.145464Z","end":"2026-07-24T17:24:15.256052Z","steps":["trace[847498134] 'process raft request' (duration: 110.368738ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:15.255941Z","caller":"traceutil/trace.go:171","msg":"trace[1883635911] transaction","detail":"{read_only:false; response_revision:1436; number_of_response:1; }","duration":"110.420679ms","start":"2026-07-24T17:24:15.145449Z","end":"2026-07-24T17:24:15.25587Z","steps":["trace[1883635911] 'process raft request' (duration: 41.188127ms)","trace[1883635911] 'compare' (duration: 69.06278ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:15.674992Z","caller":"traceutil/trace.go:171","msg":"trace[1376831503] linearizableReadLoop","detail":"{readStateIndex:1497; appliedIndex:1496; }","duration":"136.141316ms","start":"2026-07-24T17:24:15.538829Z","end":"2026-07-24T17:24:15.674971Z","steps":["trace[1376831503] 'read index received' (duration: 135.965414ms)","trace[1376831503] 'applied index is now lower than readState.Index' (duration: 175.042µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:15.675088Z","caller":"traceutil/trace.go:171","msg":"trace[646190780] transaction","detail":"{read_only:false; response_revision:1438; number_of_response:1; }","duration":"144.083613ms","start":"2026-07-24T17:24:15.530973Z","end":"2026-07-24T17:24:15.675057Z","steps":["trace[646190780] 'process raft request' (duration: 143.861811ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:15.675169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.309577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/kube-node-lease/\" range_end:\"/registry/ingress/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:24:15.675478Z","caller":"traceutil/trace.go:171","msg":"trace[737634377] range","detail":"{range_begin:/registry/ingress/kube-node-lease/; range_end:/registry/ingress/kube-node-lease0; response_count:0; response_revision:1438; }","duration":"136.64115ms","start":"2026-07-24T17:24:15.538813Z","end":"2026-07-24T17:24:15.675454Z","steps":["trace[737634377] 'agreement among raft nodes before linearized reading' (duration: 136.288407ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:15.675665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.403982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-public/\" range_end:\"/registry/deployments/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:24:15.675733Z","caller":"traceutil/trace.go:171","msg":"trace[2131676357] range","detail":"{range_begin:/registry/deployments/kube-public/; range_end:/registry/deployments/kube-public0; response_count:0; response_revision:1438; }","duration":"101.496034ms","start":"2026-07-24T17:24:15.574215Z","end":"2026-07-24T17:24:15.675711Z","steps":["trace[2131676357] 'agreement among raft nodes before linearized reading' (duration: 101.386333ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:15.67641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.718299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" ","response":"range_response_count:1 size:1036305"} {"level":"info","ts":"2026-07-24T17:24:15.676461Z","caller":"traceutil/trace.go:171","msg":"trace[1841610921] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1; range_end:; response_count:1; response_revision:1438; }","duration":"111.794201ms","start":"2026-07-24T17:24:15.564654Z","end":"2026-07-24T17:24:15.676449Z","steps":["trace[1841610921] 'agreement among raft nodes before linearized reading' (duration: 110.892393ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:17.639462Z","caller":"traceutil/trace.go:171","msg":"trace[1313135421] transaction","detail":"{read_only:false; response_revision:1443; number_of_response:1; }","duration":"376.239379ms","start":"2026-07-24T17:24:17.263197Z","end":"2026-07-24T17:24:17.639436Z","steps":["trace[1313135421] 'process raft request' (duration: 376.048418ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:17.639757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:17.263182Z","time spent":"376.3769ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:24:17.809247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.244734ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-24T17:24:17.809367Z","caller":"traceutil/trace.go:171","msg":"trace[414935429] linearizableReadLoop","detail":"{readStateIndex:1503; appliedIndex:1501; }","duration":"544.490285ms","start":"2026-07-24T17:24:17.264859Z","end":"2026-07-24T17:24:17.809349Z","steps":["trace[414935429] 'read index received' (duration: 374.469554ms)","trace[414935429] 'applied index is now lower than readState.Index' (duration: 170.019551ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:17.809443Z","caller":"traceutil/trace.go:171","msg":"trace[1342627893] transaction","detail":"{read_only:false; response_revision:1444; number_of_response:1; }","duration":"545.636805ms","start":"2026-07-24T17:24:17.263776Z","end":"2026-07-24T17:24:17.809413Z","steps":["trace[1342627893] 'process raft request' (duration: 440.120029ms)","trace[1342627893] 'compare' (duration: 104.988102ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:17.809521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.451277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/cilium-config\" ","response":"range_response_count:1 size:6531"} {"level":"warn","ts":"2026-07-24T17:24:17.809517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.629487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-public/default\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-07-24T17:24:17.809606Z","caller":"traceutil/trace.go:171","msg":"trace[409806635] range","detail":"{range_begin:/registry/serviceaccounts/kube-public/default; range_end:; response_count:1; response_revision:1444; }","duration":"544.741277ms","start":"2026-07-24T17:24:17.264847Z","end":"2026-07-24T17:24:17.809588Z","steps":["trace[409806635] 'agreement among raft nodes before linearized reading' (duration: 544.579136ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:17.809614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:17.263761Z","time spent":"545.752816ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:24:17.809653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:17.264841Z","time spent":"544.802428ms","remote":"127.0.0.1:44244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":200,"request content":"key:\"/registry/serviceaccounts/kube-public/default\" "} {"level":"warn","ts":"2026-07-24T17:24:17.80969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.946989ms","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-24T17:24:17.809725Z","caller":"traceutil/trace.go:171","msg":"trace[591710681] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1444; }","duration":"130.012061ms","start":"2026-07-24T17:24:17.679704Z","end":"2026-07-24T17:24:17.809716Z","steps":["trace[591710681] 'agreement among raft nodes before linearized reading' (duration: 129.89486ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:17.809563Z","caller":"traceutil/trace.go:171","msg":"trace[715350365] range","detail":"{range_begin:/registry/configmaps/kube-system/cilium-config; range_end:; response_count:1; response_revision:1444; }","duration":"542.500957ms","start":"2026-07-24T17:24:17.267051Z","end":"2026-07-24T17:24:17.809552Z","steps":["trace[715350365] 'agreement among raft nodes before linearized reading' (duration: 542.414616ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:17.809993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:17.267046Z","time spent":"542.909421ms","remote":"127.0.0.1:44168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":6552,"request content":"key:\"/registry/configmaps/kube-system/cilium-config\" "} {"level":"warn","ts":"2026-07-24T17:24:17.810078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.670324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/local-path-storage/\" range_end:\"/registry/cronjobs/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-24T17:24:17.810072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.305843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" limit:500 ","response":"range_response_count:2 size:8921"} {"level":"info","ts":"2026-07-24T17:24:17.810271Z","caller":"traceutil/trace.go:171","msg":"trace[1119732297] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:2; response_revision:1444; }","duration":"527.510686ms","start":"2026-07-24T17:24:17.282733Z","end":"2026-07-24T17:24:17.810244Z","steps":["trace[1119732297] 'agreement among raft nodes before linearized reading' (duration: 527.220354ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:17.810226Z","caller":"traceutil/trace.go:171","msg":"trace[1068410380] range","detail":"{range_begin:/registry/cronjobs/local-path-storage/; range_end:/registry/cronjobs/local-path-storage0; response_count:0; response_revision:1444; }","duration":"529.826516ms","start":"2026-07-24T17:24:17.280376Z","end":"2026-07-24T17:24:17.810202Z","steps":["trace[1068410380] 'agreement among raft nodes before linearized reading' (duration: 529.619984ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:17.810314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:17.282722Z","time spent":"527.578997ms","remote":"127.0.0.1:44500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":2,"response size":8942,"request content":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" limit:500 "} {"level":"warn","ts":"2026-07-24T17:24:17.810414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:17.280367Z","time spent":"530.023407ms","remote":"127.0.0.1:44290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":26,"request content":"key:\"/registry/cronjobs/local-path-storage/\" range_end:\"/registry/cronjobs/local-path-storage0\" limit:500 "} {"level":"info","ts":"2026-07-24T17:24:18.142182Z","caller":"traceutil/trace.go:171","msg":"trace[1691417603] transaction","detail":"{read_only:false; response_revision:1446; number_of_response:1; }","duration":"140.050313ms","start":"2026-07-24T17:24:18.002066Z","end":"2026-07-24T17:24:18.142117Z","steps":["trace[1691417603] 'process raft request' (duration: 139.783929ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:18.360242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.260634ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-24T17:24:18.360333Z","caller":"traceutil/trace.go:171","msg":"trace[1543293896] linearizableReadLoop","detail":"{readStateIndex:1506; appliedIndex:1505; }","duration":"213.864423ms","start":"2026-07-24T17:24:18.146454Z","end":"2026-07-24T17:24:18.360318Z","steps":["trace[1543293896] 'read index received' (duration: 111.381136ms)","trace[1543293896] 'applied index is now lower than readState.Index' (duration: 102.482197ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:18.360412Z","caller":"traceutil/trace.go:171","msg":"trace[806558129] transaction","detail":"{read_only:false; response_revision:1447; number_of_response:1; }","duration":"214.403428ms","start":"2026-07-24T17:24:18.145997Z","end":"2026-07-24T17:24:18.360401Z","steps":["trace[806558129] 'process raft request' (duration: 111.903821ms)","trace[806558129] 'compare' (duration: 102.025192ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:18.36051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.008725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/coredns\" ","response":"range_response_count:1 size:612"} {"level":"info","ts":"2026-07-24T17:24:18.360558Z","caller":"traceutil/trace.go:171","msg":"trace[1657999883] range","detail":"{range_begin:/registry/configmaps/kube-system/coredns; range_end:; response_count:1; response_revision:1447; }","duration":"214.085746ms","start":"2026-07-24T17:24:18.146457Z","end":"2026-07-24T17:24:18.360543Z","steps":["trace[1657999883] 'agreement among raft nodes before linearized reading' (duration: 213.991165ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:18.360565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.460008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/local-path-storage/\" range_end:\"/registry/ingress/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-24T17:24:18.360571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.609206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/kube-system/\" range_end:\"/registry/networkpolicies/kube-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:24:18.360648Z","caller":"traceutil/trace.go:171","msg":"trace[1749269745] range","detail":"{range_begin:/registry/ingress/local-path-storage/; range_end:/registry/ingress/local-path-storage0; response_count:0; response_revision:1447; }","duration":"139.616499ms","start":"2026-07-24T17:24:18.221007Z","end":"2026-07-24T17:24:18.360624Z","steps":["trace[1749269745] 'agreement among raft nodes before linearized reading' (duration: 139.463768ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:18.360654Z","caller":"traceutil/trace.go:171","msg":"trace[2063355611] range","detail":"{range_begin:/registry/networkpolicies/kube-system/; range_end:/registry/networkpolicies/kube-system0; response_count:0; response_revision:1447; }","duration":"142.742138ms","start":"2026-07-24T17:24:18.217889Z","end":"2026-07-24T17:24:18.360631Z","steps":["trace[2063355611] 'agreement among raft nodes before linearized reading' (duration: 142.614546ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:18.360779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.320618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:1 size:3017"} {"level":"info","ts":"2026-07-24T17:24:18.360822Z","caller":"traceutil/trace.go:171","msg":"trace[1154649963] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:1; response_revision:1447; }","duration":"214.395719ms","start":"2026-07-24T17:24:18.146413Z","end":"2026-07-24T17:24:18.360809Z","steps":["trace[1154649963] 'agreement among raft nodes before linearized reading' (duration: 214.321218ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:18.576643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.341912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/\" range_end:\"/registry/pods/kube-system0\" limit:500 ","response":"range_response_count:10 size:65274"} {"level":"info","ts":"2026-07-24T17:24:18.576717Z","caller":"traceutil/trace.go:171","msg":"trace[304243555] range","detail":"{range_begin:/registry/pods/kube-system/; range_end:/registry/pods/kube-system0; response_count:10; response_revision:1447; }","duration":"115.447723ms","start":"2026-07-24T17:24:18.461254Z","end":"2026-07-24T17:24:18.576702Z","steps":["trace[304243555] 'range keys from in-memory index tree' (duration: 115.14292ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:19.545094Z","caller":"traceutil/trace.go:171","msg":"trace[2087913811] linearizableReadLoop","detail":"{readStateIndex:1507; appliedIndex:1506; }","duration":"349.196884ms","start":"2026-07-24T17:24:19.195874Z","end":"2026-07-24T17:24:19.545071Z","steps":["trace[2087913811] 'read index received' (duration: 349.101344ms)","trace[2087913811] 'applied index is now lower than readState.Index' (duration: 94.59µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:19.545169Z","caller":"traceutil/trace.go:171","msg":"trace[1317613049] transaction","detail":"{read_only:false; response_revision:1448; number_of_response:1; }","duration":"351.110362ms","start":"2026-07-24T17:24:19.194019Z","end":"2026-07-24T17:24:19.54513Z","steps":["trace[1317613049] 'process raft request' (duration: 350.90979ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:19.545249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.351906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2918"} {"level":"info","ts":"2026-07-24T17:24:19.545288Z","caller":"traceutil/trace.go:171","msg":"trace[1543888999] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:1448; }","duration":"349.451017ms","start":"2026-07-24T17:24:19.195828Z","end":"2026-07-24T17:24:19.545279Z","steps":["trace[1543888999] 'agreement among raft nodes before linearized reading' (duration: 349.352126ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:19.545325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:19.195808Z","time spent":"349.508818ms","remote":"127.0.0.1:44520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":2939,"request content":"key:\"/registry/daemonsets/kube-system/kube-proxy\" "} {"level":"warn","ts":"2026-07-24T17:24:19.54534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:19.193996Z","time spent":"351.254804ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:24:20.22156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.659057ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:26"} {"level":"info","ts":"2026-07-24T17:24:20.22174Z","caller":"traceutil/trace.go:171","msg":"trace[1200200295] linearizableReadLoop","detail":"{readStateIndex:1508; appliedIndex:1507; }","duration":"676.5654ms","start":"2026-07-24T17:24:19.545157Z","end":"2026-07-24T17:24:20.221723Z","steps":["trace[1200200295] 'read index received' (duration: 211.663521ms)","trace[1200200295] 'applied index is now lower than readState.Index' (duration: 464.899999ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:20.221889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.98548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/local-path-storage/\" range_end:\"/registry/rolebindings/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-24T17:24:20.22194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.669777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2918"} {"level":"info","ts":"2026-07-24T17:24:20.221984Z","caller":"traceutil/trace.go:171","msg":"trace[965170023] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:1448; }","duration":"600.744807ms","start":"2026-07-24T17:24:19.621227Z","end":"2026-07-24T17:24:20.221972Z","steps":["trace[965170023] 'agreement among raft nodes before linearized reading' (duration: 600.658347ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:20.221977Z","caller":"traceutil/trace.go:171","msg":"trace[1422883141] range","detail":"{range_begin:/registry/rolebindings/local-path-storage/; range_end:/registry/rolebindings/local-path-storage0; response_count:0; response_revision:1448; }","duration":"966.142361ms","start":"2026-07-24T17:24:19.255814Z","end":"2026-07-24T17:24:20.221957Z","steps":["trace[1422883141] 'agreement among raft nodes before linearized reading' (duration: 965.9467ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:20.221999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.913363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/\" range_end:\"/registry/serviceaccounts/kube-system0\" limit:500 ","response":"range_response_count:37 size:8042"} {"level":"warn","ts":"2026-07-24T17:24:20.222026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:19.621207Z","time spent":"600.810258ms","remote":"127.0.0.1:44520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":2939,"request content":"key:\"/registry/daemonsets/kube-system/kube-proxy\" "} {"level":"info","ts":"2026-07-24T17:24:20.222034Z","caller":"traceutil/trace.go:171","msg":"trace[941689912] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/; range_end:/registry/serviceaccounts/kube-system0; response_count:37; response_revision:1448; }","duration":"699.988353ms","start":"2026-07-24T17:24:19.522035Z","end":"2026-07-24T17:24:20.222023Z","steps":["trace[941689912] 'agreement among raft nodes before linearized reading' (duration: 699.69378ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:20.222032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:19.255779Z","time spent":"966.241582ms","remote":"127.0.0.1:44392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":0,"response size":26,"request content":"key:\"/registry/rolebindings/local-path-storage/\" range_end:\"/registry/rolebindings/local-path-storage0\" limit:500 "} {"level":"warn","ts":"2026-07-24T17:24:20.222067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:19.522009Z","time spent":"700.048604ms","remote":"127.0.0.1:44244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":37,"response size":8063,"request content":"key:\"/registry/serviceaccounts/kube-system/\" range_end:\"/registry/serviceaccounts/kube-system0\" limit:500 "} {"level":"warn","ts":"2026-07-24T17:24:20.221998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"984.398667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4709"} {"level":"info","ts":"2026-07-24T17:24:20.222202Z","caller":"traceutil/trace.go:171","msg":"trace[763841116] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:1448; }","duration":"984.676439ms","start":"2026-07-24T17:24:19.237513Z","end":"2026-07-24T17:24:20.22219Z","steps":["trace[763841116] 'agreement among raft nodes before linearized reading' (duration: 984.317586ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:20.222278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:19.237495Z","time spent":"984.77024ms","remote":"127.0.0.1:44500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":4730,"request content":"key:\"/registry/deployments/kube-system/cilium-operator\" "} {"level":"warn","ts":"2026-07-24T17:24:20.221955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.788045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-24T17:24:20.222308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.946495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-07-24T17:24:20.22237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.758438ms","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-24T17:24:20.222393Z","caller":"traceutil/trace.go:171","msg":"trace[1904326327] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1448; }","duration":"401.069267ms","start":"2026-07-24T17:24:19.821314Z","end":"2026-07-24T17:24:20.222383Z","steps":["trace[1904326327] 'agreement among raft nodes before linearized reading' (duration: 400.916006ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:20.222391Z","caller":"traceutil/trace.go:171","msg":"trace[1237735706] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1448; }","duration":"400.26697ms","start":"2026-07-24T17:24:19.82211Z","end":"2026-07-24T17:24:20.222377Z","steps":["trace[1237735706] 'agreement among raft nodes before linearized reading' (duration: 399.786646ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:20.222416Z","caller":"traceutil/trace.go:171","msg":"trace[1285549284] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1448; }","duration":"327.824118ms","start":"2026-07-24T17:24:19.894578Z","end":"2026-07-24T17:24:20.222402Z","steps":["trace[1285549284] 'agreement among raft nodes before linearized reading' (duration: 327.711937ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:20.222442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:19.821293Z","time spent":"401.135238ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":525,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-24T17:24:20.222449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:19.894567Z","time spent":"327.874909ms","remote":"127.0.0.1:44306","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-07-24T17:24:20.222441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:19.82209Z","time spent":"400.340801ms","remote":"127.0.0.1:44050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-24T17:24:20.222383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.358803ms","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-24T17:24:20.222543Z","caller":"traceutil/trace.go:171","msg":"trace[1285694436] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1448; }","duration":"579.517015ms","start":"2026-07-24T17:24:19.643017Z","end":"2026-07-24T17:24:20.222534Z","steps":["trace[1285694436] 'agreement among raft nodes before linearized reading' (duration: 579.311923ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:20.222575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:19.642951Z","time spent":"579.616456ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-24T17:24:20.403519Z","caller":"traceutil/trace.go:171","msg":"trace[61136445] transaction","detail":"{read_only:false; response_revision:1449; number_of_response:1; }","duration":"176.887914ms","start":"2026-07-24T17:24:20.22659Z","end":"2026-07-24T17:24:20.403478Z","steps":["trace[61136445] 'process raft request' (duration: 176.562041ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:20.429876Z","caller":"traceutil/trace.go:171","msg":"trace[1412759229] transaction","detail":"{read_only:false; response_revision:1451; number_of_response:1; }","duration":"203.071258ms","start":"2026-07-24T17:24:20.226775Z","end":"2026-07-24T17:24:20.429847Z","steps":["trace[1412759229] 'process raft request' (duration: 202.960557ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:20.430056Z","caller":"traceutil/trace.go:171","msg":"trace[1409641174] linearizableReadLoop","detail":"{readStateIndex:1512; appliedIndex:1508; }","duration":"200.490773ms","start":"2026-07-24T17:24:20.229518Z","end":"2026-07-24T17:24:20.430008Z","steps":["trace[1409641174] 'read index received' (duration: 173.700884ms)","trace[1409641174] 'applied index is now lower than readState.Index' (duration: 26.788239ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:20.430105Z","caller":"traceutil/trace.go:171","msg":"trace[464758272] transaction","detail":"{read_only:false; response_revision:1452; number_of_response:1; }","duration":"200.762426ms","start":"2026-07-24T17:24:20.229327Z","end":"2026-07-24T17:24:20.430089Z","steps":["trace[464758272] 'process raft request' (duration: 200.470313ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:20.429901Z","caller":"traceutil/trace.go:171","msg":"trace[1160412956] transaction","detail":"{read_only:false; response_revision:1450; number_of_response:1; }","duration":"203.212409ms","start":"2026-07-24T17:24:20.226631Z","end":"2026-07-24T17:24:20.429844Z","steps":["trace[1160412956] 'process raft request' (duration: 202.884326ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:20.430271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.717665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2918"} {"level":"info","ts":"2026-07-24T17:24:20.430318Z","caller":"traceutil/trace.go:171","msg":"trace[723929738] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:1452; }","duration":"200.821446ms","start":"2026-07-24T17:24:20.229485Z","end":"2026-07-24T17:24:20.430306Z","steps":["trace[723929738] 'agreement among raft nodes before linearized reading' (duration: 200.700265ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:20.445251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.077966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/local-path-storage/\" range_end:\"/registry/roles/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:24:20.445315Z","caller":"traceutil/trace.go:171","msg":"trace[219407403] range","detail":"{range_begin:/registry/roles/local-path-storage/; range_end:/registry/roles/local-path-storage0; response_count:0; response_revision:1453; }","duration":"136.179327ms","start":"2026-07-24T17:24:20.309121Z","end":"2026-07-24T17:24:20.4453Z","steps":["trace[219407403] 'agreement among raft nodes before linearized reading' (duration: 136.070976ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:20.445366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.640595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4709"} {"level":"info","ts":"2026-07-24T17:24:20.445415Z","caller":"traceutil/trace.go:171","msg":"trace[1559755691] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:1453; }","duration":"144.749387ms","start":"2026-07-24T17:24:20.300655Z","end":"2026-07-24T17:24:20.445404Z","steps":["trace[1559755691] 'agreement among raft nodes before linearized reading' (duration: 144.635466ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:21.765983Z","caller":"traceutil/trace.go:171","msg":"trace[968847259] linearizableReadLoop","detail":"{readStateIndex:1515; appliedIndex:1514; }","duration":"192.979337ms","start":"2026-07-24T17:24:21.572985Z","end":"2026-07-24T17:24:21.765964Z","steps":["trace[968847259] 'read index received' (duration: 192.838466ms)","trace[968847259] 'applied index is now lower than readState.Index' (duration: 140.051µs)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:21.766113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.115709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-2mflv\" ","response":"range_response_count:1 size:4482"} {"level":"info","ts":"2026-07-24T17:24:21.766136Z","caller":"traceutil/trace.go:171","msg":"trace[1546184237] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-2mflv; range_end:; response_count:1; response_revision:1455; }","duration":"193.177569ms","start":"2026-07-24T17:24:21.572951Z","end":"2026-07-24T17:24:21.766129Z","steps":["trace[1546184237] 'agreement among raft nodes before linearized reading' (duration: 193.117668ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:21.76612Z","caller":"traceutil/trace.go:171","msg":"trace[1379983604] transaction","detail":"{read_only:false; response_revision:1455; number_of_response:1; }","duration":"216.107296ms","start":"2026-07-24T17:24:21.549983Z","end":"2026-07-24T17:24:21.766091Z","steps":["trace[1379983604] 'process raft request' (duration: 215.858613ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:21.766256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.883004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4134"} {"level":"info","ts":"2026-07-24T17:24:21.766326Z","caller":"traceutil/trace.go:171","msg":"trace[602913640] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:1455; }","duration":"179.005866ms","start":"2026-07-24T17:24:21.587305Z","end":"2026-07-24T17:24:21.766311Z","steps":["trace[602913640] 'agreement among raft nodes before linearized reading' (duration: 178.814214ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:22.820977Z","caller":"traceutil/trace.go:171","msg":"trace[1506729279] linearizableReadLoop","detail":"{readStateIndex:1516; appliedIndex:1515; }","duration":"407.187986ms","start":"2026-07-24T17:24:22.413763Z","end":"2026-07-24T17:24:22.820951Z","steps":["trace[1506729279] 'read index received' (duration: 406.920754ms)","trace[1506729279] 'applied index is now lower than readState.Index' (duration: 265.972µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:22.821109Z","caller":"traceutil/trace.go:171","msg":"trace[1284920682] transaction","detail":"{read_only:false; response_revision:1456; number_of_response:1; }","duration":"409.613299ms","start":"2026-07-24T17:24:22.411485Z","end":"2026-07-24T17:24:22.821098Z","steps":["trace[1284920682] 'process raft request' (duration: 409.306656ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:22.821221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:22.411458Z","time spent":"409.67943ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:24:22.821319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.016167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system::extension-apiserver-authentication-reader\" ","response":"range_response_count:1 size:856"} {"level":"info","ts":"2026-07-24T17:24:22.821395Z","caller":"traceutil/trace.go:171","msg":"trace[2139329321] range","detail":"{range_begin:/registry/rolebindings/kube-system/system::extension-apiserver-authentication-reader; range_end:; response_count:1; response_revision:1456; }","duration":"396.124598ms","start":"2026-07-24T17:24:22.425248Z","end":"2026-07-24T17:24:22.821372Z","steps":["trace[2139329321] 'agreement among raft nodes before linearized reading' (duration: 395.994447ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:22.821436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:22.425232Z","time spent":"396.19508ms","remote":"127.0.0.1:44392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":877,"request content":"key:\"/registry/rolebindings/kube-system/system::extension-apiserver-authentication-reader\" "} {"level":"warn","ts":"2026-07-24T17:24:22.821604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.825532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/kubeadm:nodes-kubeadm-config\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-07-24T17:24:22.821671Z","caller":"traceutil/trace.go:171","msg":"trace[2080224458] range","detail":"{range_begin:/registry/rolebindings/kube-system/kubeadm:nodes-kubeadm-config; range_end:; response_count:1; response_revision:1456; }","duration":"407.911063ms","start":"2026-07-24T17:24:22.41374Z","end":"2026-07-24T17:24:22.821651Z","steps":["trace[2080224458] 'agreement among raft nodes before linearized reading' (duration: 407.791232ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:22.82172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:22.413732Z","time spent":"407.975463ms","remote":"127.0.0.1:44392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":577,"request content":"key:\"/registry/rolebindings/kube-system/kubeadm:nodes-kubeadm-config\" "} {"level":"warn","ts":"2026-07-24T17:24:22.82173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.367344ms","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-24T17:24:22.821734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.307204ms","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-24T17:24:22.821795Z","caller":"traceutil/trace.go:171","msg":"trace[1634033349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1456; }","duration":"387.469936ms","start":"2026-07-24T17:24:22.434308Z","end":"2026-07-24T17:24:22.821778Z","steps":["trace[1634033349] 'agreement among raft nodes before linearized reading' (duration: 387.288204ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:22.821806Z","caller":"traceutil/trace.go:171","msg":"trace[1755579105] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1456; }","duration":"387.408065ms","start":"2026-07-24T17:24:22.434382Z","end":"2026-07-24T17:24:22.82179Z","steps":["trace[1755579105] 'agreement among raft nodes before linearized reading' (duration: 387.147033ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:22.821846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:22.434289Z","time spent":"387.543776ms","remote":"127.0.0.1:44306","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-07-24T17:24:22.821851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:22.434368Z","time spent":"387.471215ms","remote":"127.0.0.1:44306","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-07-24T17:24:22.821849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.367587ms","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-24T17:24:22.821917Z","caller":"traceutil/trace.go:171","msg":"trace[687762565] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1456; }","duration":"267.464838ms","start":"2026-07-24T17:24:22.554432Z","end":"2026-07-24T17:24:22.821897Z","steps":["trace[687762565] 'agreement among raft nodes before linearized reading' (duration: 267.345667ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:22.821722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.969391ms","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-24T17:24:22.822119Z","caller":"traceutil/trace.go:171","msg":"trace[1345828899] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1456; }","duration":"387.376225ms","start":"2026-07-24T17:24:22.434689Z","end":"2026-07-24T17:24:22.822065Z","steps":["trace[1345828899] 'agreement among raft nodes before linearized reading' (duration: 386.810599ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:22.822209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:22.434679Z","time spent":"387.512096ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-24T17:24:22.947841Z","caller":"traceutil/trace.go:171","msg":"trace[844439502] transaction","detail":"{read_only:false; response_revision:1457; number_of_response:1; }","duration":"121.042647ms","start":"2026-07-24T17:24:22.826772Z","end":"2026-07-24T17:24:22.947814Z","steps":["trace[844439502] 'process raft request' (duration: 75.985052ms)","trace[844439502] 'compare' (duration: 44.845293ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:22.948114Z","caller":"traceutil/trace.go:171","msg":"trace[1222851287] transaction","detail":"{read_only:false; response_revision:1458; number_of_response:1; }","duration":"121.227339ms","start":"2026-07-24T17:24:22.826875Z","end":"2026-07-24T17:24:22.948102Z","steps":["trace[1222851287] 'process raft request' (duration: 120.875235ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:22.948338Z","caller":"traceutil/trace.go:171","msg":"trace[688930692] transaction","detail":"{read_only:false; response_revision:1459; number_of_response:1; }","duration":"121.37179ms","start":"2026-07-24T17:24:22.826943Z","end":"2026-07-24T17:24:22.948314Z","steps":["trace[688930692] 'process raft request' (duration: 121.120187ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:22.948608Z","caller":"traceutil/trace.go:171","msg":"trace[1603558552] transaction","detail":"{read_only:false; response_revision:1460; number_of_response:1; }","duration":"121.40765ms","start":"2026-07-24T17:24:22.827177Z","end":"2026-07-24T17:24:22.948585Z","steps":["trace[1603558552] 'process raft request' (duration: 121.060977ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:23.972993Z","caller":"traceutil/trace.go:171","msg":"trace[1001699469] linearizableReadLoop","detail":"{readStateIndex:1521; appliedIndex:1520; }","duration":"142.364807ms","start":"2026-07-24T17:24:23.830602Z","end":"2026-07-24T17:24:23.972967Z","steps":["trace[1001699469] 'read index received' (duration: 142.179875ms)","trace[1001699469] 'applied index is now lower than readState.Index' (duration: 183.842µs)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:23.973183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.551179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/kubeadm:nodes-kubeadm-config\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-07-24T17:24:23.973242Z","caller":"traceutil/trace.go:171","msg":"trace[853642923] range","detail":"{range_begin:/registry/roles/kube-system/kubeadm:nodes-kubeadm-config; range_end:; response_count:1; response_revision:1461; }","duration":"142.654879ms","start":"2026-07-24T17:24:23.830575Z","end":"2026-07-24T17:24:23.97323Z","steps":["trace[853642923] 'agreement among raft nodes before linearized reading' (duration: 142.533318ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:23.973315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.389601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system::leader-locking-kube-controller-manager\" ","response":"range_response_count:1 size:688"} {"level":"info","ts":"2026-07-24T17:24:23.9734Z","caller":"traceutil/trace.go:171","msg":"trace[1101141949] range","detail":"{range_begin:/registry/roles/kube-system/system::leader-locking-kube-controller-manager; range_end:; response_count:1; response_revision:1461; }","duration":"123.511712ms","start":"2026-07-24T17:24:23.849866Z","end":"2026-07-24T17:24:23.973378Z","steps":["trace[1101141949] 'agreement among raft nodes before linearized reading' (duration: 123.37497ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:23.973132Z","caller":"traceutil/trace.go:171","msg":"trace[2060380479] transaction","detail":"{read_only:false; response_revision:1461; number_of_response:1; }","duration":"202.632208ms","start":"2026-07-24T17:24:23.77046Z","end":"2026-07-24T17:24:23.973092Z","steps":["trace[2060380479] 'process raft request' (duration: 202.337105ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:25.278517Z","caller":"traceutil/trace.go:171","msg":"trace[1868118507] transaction","detail":"{read_only:false; response_revision:1465; number_of_response:1; }","duration":"323.293723ms","start":"2026-07-24T17:24:24.955191Z","end":"2026-07-24T17:24:25.278484Z","steps":["trace[1868118507] 'process raft request' (duration: 282.492578ms)","trace[1868118507] 'compare' (duration: 40.558932ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:25.278742Z","caller":"traceutil/trace.go:171","msg":"trace[909151622] transaction","detail":"{read_only:false; response_revision:1466; number_of_response:1; }","duration":"323.511505ms","start":"2026-07-24T17:24:24.95521Z","end":"2026-07-24T17:24:25.278722Z","steps":["trace[909151622] 'process raft request' (duration: 323.213092ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:25.278847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:24.955191Z","time spent":"323.604746ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:24:25.278873Z","caller":"traceutil/trace.go:171","msg":"trace[749398449] linearizableReadLoop","detail":"{readStateIndex:1528; appliedIndex:1524; }","duration":"318.643987ms","start":"2026-07-24T17:24:24.960202Z","end":"2026-07-24T17:24:25.278846Z","steps":["trace[749398449] 'read index received' (duration: 23.952519ms)","trace[749398449] 'applied index is now lower than readState.Index' (duration: 294.690368ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:25.27912Z","caller":"traceutil/trace.go:171","msg":"trace[416401072] transaction","detail":"{read_only:false; response_revision:1467; number_of_response:1; }","duration":"322.662597ms","start":"2026-07-24T17:24:24.95644Z","end":"2026-07-24T17:24:25.279103Z","steps":["trace[416401072] 'process raft request' (duration: 322.146362ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:25.279186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:24.955176Z","time spent":"323.431384ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:24:25.27925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:24.956431Z","time spent":"322.735197ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:24:25.279393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.196503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:1 size:212"} {"level":"info","ts":"2026-07-24T17:24:25.279424Z","caller":"traceutil/trace.go:171","msg":"trace[419325865] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:1; response_revision:1467; }","duration":"319.243023ms","start":"2026-07-24T17:24:24.960171Z","end":"2026-07-24T17:24:25.279414Z","steps":["trace[419325865] 'agreement among raft nodes before linearized reading' (duration: 319.182192ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:25.279454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:24.960163Z","time spent":"319.284003ms","remote":"127.0.0.1:44244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":233,"request content":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" "} {"level":"warn","ts":"2026-07-24T17:24:25.279618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.177581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-07-24T17:24:25.279704Z","caller":"traceutil/trace.go:171","msg":"trace[989021936] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:1467; }","duration":"291.298434ms","start":"2026-07-24T17:24:24.988384Z","end":"2026-07-24T17:24:25.279683Z","steps":["trace[989021936] 'agreement among raft nodes before linearized reading' (duration: 291.133223ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:27.585376Z","caller":"traceutil/trace.go:171","msg":"trace[46223361] transaction","detail":"{read_only:false; response_revision:1472; number_of_response:1; }","duration":"298.985703ms","start":"2026-07-24T17:24:27.28636Z","end":"2026-07-24T17:24:27.585346Z","steps":["trace[46223361] 'process raft request' (duration: 223.052246ms)","trace[46223361] 'compare' (duration: 75.743604ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:27.585493Z","caller":"traceutil/trace.go:171","msg":"trace[1144106163] linearizableReadLoop","detail":"{readStateIndex:1534; appliedIndex:1531; }","duration":"284.698224ms","start":"2026-07-24T17:24:27.300769Z","end":"2026-07-24T17:24:27.585468Z","steps":["trace[1144106163] 'read index received' (duration: 4.75516ms)","trace[1144106163] 'applied index is now lower than readState.Index' (duration: 279.941624ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:27.585601Z","caller":"traceutil/trace.go:171","msg":"trace[1215829698] transaction","detail":"{read_only:false; response_revision:1473; number_of_response:1; }","duration":"298.780861ms","start":"2026-07-24T17:24:27.286809Z","end":"2026-07-24T17:24:27.58559Z","steps":["trace[1215829698] 'process raft request' (duration: 298.485628ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:27.586405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.601583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:87 size:64784"} {"level":"info","ts":"2026-07-24T17:24:27.586492Z","caller":"traceutil/trace.go:171","msg":"trace[958477190] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:87; response_revision:1473; }","duration":"285.744714ms","start":"2026-07-24T17:24:27.300727Z","end":"2026-07-24T17:24:27.586472Z","steps":["trace[958477190] 'agreement among raft nodes before linearized reading' (duration: 284.932046ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:27.617496Z","caller":"traceutil/trace.go:171","msg":"trace[350021123] transaction","detail":"{read_only:false; response_revision:1474; number_of_response:1; }","duration":"299.150515ms","start":"2026-07-24T17:24:27.318317Z","end":"2026-07-24T17:24:27.617467Z","steps":["trace[350021123] 'process raft request' (duration: 298.64629ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:27.617778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.773938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:87 size:64784"} {"level":"info","ts":"2026-07-24T17:24:27.61785Z","caller":"traceutil/trace.go:171","msg":"trace[1840154658] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:87; response_revision:1474; }","duration":"312.876579ms","start":"2026-07-24T17:24:27.304955Z","end":"2026-07-24T17:24:27.617832Z","steps":["trace[1840154658] 'agreement among raft nodes before linearized reading' (duration: 312.134742ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:27.617896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:27.304948Z","time spent":"312.93447ms","remote":"127.0.0.1:44136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":87,"response size":64805,"request content":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 "} {"level":"warn","ts":"2026-07-24T17:24:28.236979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.45405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:24:28.237077Z","caller":"traceutil/trace.go:171","msg":"trace[712575069] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1475; }","duration":"118.657523ms","start":"2026-07-24T17:24:28.118397Z","end":"2026-07-24T17:24:28.237055Z","steps":["trace[712575069] 'count revisions from in-memory index tree' (duration: 118.343249ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:28.237138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.480685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-07-24T17:24:28.237224Z","caller":"traceutil/trace.go:171","msg":"trace[430818671] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pod-garbage-collector; range_end:; response_count:1; response_revision:1475; }","duration":"108.626926ms","start":"2026-07-24T17:24:28.128575Z","end":"2026-07-24T17:24:28.237202Z","steps":["trace[430818671] 'range keys from in-memory index tree' (duration: 108.389444ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:28.237509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.810831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:87 size:64784"} {"level":"info","ts":"2026-07-24T17:24:28.237589Z","caller":"traceutil/trace.go:171","msg":"trace[39343319] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:87; response_revision:1475; }","duration":"128.937932ms","start":"2026-07-24T17:24:28.108633Z","end":"2026-07-24T17:24:28.237571Z","steps":["trace[39343319] 'range keys from in-memory index tree' (duration: 128.311986ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:29.737683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.489598ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:26"} {"level":"info","ts":"2026-07-24T17:24:29.737811Z","caller":"traceutil/trace.go:171","msg":"trace[1797853566] linearizableReadLoop","detail":"{readStateIndex:1540; appliedIndex:1539; }","duration":"281.909217ms","start":"2026-07-24T17:24:29.455882Z","end":"2026-07-24T17:24:29.737791Z","steps":["trace[1797853566] 'read index received' (duration: 177.292997ms)","trace[1797853566] 'applied index is now lower than readState.Index' (duration: 104.61476ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:29.737981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.281315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/token-cleaner\" ","response":"range_response_count:1 size:191"} {"level":"info","ts":"2026-07-24T17:24:29.73802Z","caller":"traceutil/trace.go:171","msg":"trace[807963829] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/token-cleaner; range_end:; response_count:1; response_revision:1478; }","duration":"275.331425ms","start":"2026-07-24T17:24:29.462676Z","end":"2026-07-24T17:24:29.738008Z","steps":["trace[807963829] 'agreement among raft nodes before linearized reading' (duration: 275.228154ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:29.738078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.121059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" ","response":"range_response_count:1 size:224"} {"level":"info","ts":"2026-07-24T17:24:29.738224Z","caller":"traceutil/trace.go:171","msg":"trace[1623228323] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:1; response_revision:1478; }","duration":"282.328881ms","start":"2026-07-24T17:24:29.455849Z","end":"2026-07-24T17:24:29.738178Z","steps":["trace[1623228323] 'agreement among raft nodes before linearized reading' (duration: 282.023078ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:29.738317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.908929ms","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-24T17:24:29.738402Z","caller":"traceutil/trace.go:171","msg":"trace[912589919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1478; }","duration":"149.03736ms","start":"2026-07-24T17:24:29.589347Z","end":"2026-07-24T17:24:29.738384Z","steps":["trace[912589919] 'agreement among raft nodes before linearized reading' (duration: 148.699206ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:29.738317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.691227ms","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-24T17:24:29.738483Z","caller":"traceutil/trace.go:171","msg":"trace[1963790928] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1478; }","duration":"147.943059ms","start":"2026-07-24T17:24:29.590516Z","end":"2026-07-24T17:24:29.738459Z","steps":["trace[1963790928] 'agreement among raft nodes before linearized reading' (duration: 147.472154ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:29.882297Z","caller":"traceutil/trace.go:171","msg":"trace[567511526] transaction","detail":"{read_only:false; response_revision:1479; number_of_response:1; }","duration":"139.358785ms","start":"2026-07-24T17:24:29.742916Z","end":"2026-07-24T17:24:29.882274Z","steps":["trace[567511526] 'process raft request' (duration: 139.120242ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:29.882487Z","caller":"traceutil/trace.go:171","msg":"trace[1463400338] linearizableReadLoop","detail":"{readStateIndex:1542; appliedIndex:1541; }","duration":"137.464757ms","start":"2026-07-24T17:24:29.744993Z","end":"2026-07-24T17:24:29.882457Z","steps":["trace[1463400338] 'read index received' (duration: 137.196653ms)","trace[1463400338] 'applied index is now lower than readState.Index' (duration: 266.614µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:29.882513Z","caller":"traceutil/trace.go:171","msg":"trace[2101380643] transaction","detail":"{read_only:false; response_revision:1480; number_of_response:1; }","duration":"139.553839ms","start":"2026-07-24T17:24:29.74291Z","end":"2026-07-24T17:24:29.882464Z","steps":["trace[2101380643] 'process raft request' (duration: 139.313565ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:29.883075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.058993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:4 size:329960"} {"level":"info","ts":"2026-07-24T17:24:29.883131Z","caller":"traceutil/trace.go:171","msg":"trace[947358645] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1480; }","duration":"138.156773ms","start":"2026-07-24T17:24:29.744959Z","end":"2026-07-24T17:24:29.883116Z","steps":["trace[947358645] 'agreement among raft nodes before linearized reading' (duration: 137.657618ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:29.883193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.765149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:4 size:329960"} {"level":"info","ts":"2026-07-24T17:24:29.8834Z","caller":"traceutil/trace.go:171","msg":"trace[447657111] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1480; }","duration":"138.029801ms","start":"2026-07-24T17:24:29.745327Z","end":"2026-07-24T17:24:29.883357Z","steps":["trace[447657111] 'agreement among raft nodes before linearized reading' (duration: 137.381294ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:30.194602Z","caller":"traceutil/trace.go:171","msg":"trace[1151778897] linearizableReadLoop","detail":"{readStateIndex:1543; appliedIndex:1542; }","duration":"119.849934ms","start":"2026-07-24T17:24:30.074729Z","end":"2026-07-24T17:24:30.194579Z","steps":["trace[1151778897] 'read index received' (duration: 119.726743ms)","trace[1151778897] 'applied index is now lower than readState.Index' (duration: 122.171µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:30.194713Z","caller":"traceutil/trace.go:171","msg":"trace[1445827292] transaction","detail":"{read_only:false; response_revision:1481; number_of_response:1; }","duration":"164.298032ms","start":"2026-07-24T17:24:30.030385Z","end":"2026-07-24T17:24:30.194683Z","steps":["trace[1445827292] 'process raft request' (duration: 164.035409ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:30.194797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.049947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/kube-system/kube-dns\" ","response":"range_response_count:1 size:1211"} {"level":"warn","ts":"2026-07-24T17:24:30.194811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.846182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-07-24T17:24:30.194841Z","caller":"traceutil/trace.go:171","msg":"trace[422379612] range","detail":"{range_begin:/registry/services/specs/kube-system/kube-dns; range_end:; response_count:1; response_revision:1481; }","duration":"120.148238ms","start":"2026-07-24T17:24:30.074683Z","end":"2026-07-24T17:24:30.194832Z","steps":["trace[422379612] 'agreement among raft nodes before linearized reading' (duration: 120.037457ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:30.194877Z","caller":"traceutil/trace.go:171","msg":"trace[1890467676] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:1481; }","duration":"117.933743ms","start":"2026-07-24T17:24:30.076926Z","end":"2026-07-24T17:24:30.19486Z","steps":["trace[1890467676] 'agreement among raft nodes before linearized reading' (duration: 117.821652ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:30.98318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"767.915062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:24:30.983264Z","caller":"traceutil/trace.go:171","msg":"trace[915706957] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1481; }","duration":"768.060953ms","start":"2026-07-24T17:24:30.215184Z","end":"2026-07-24T17:24:30.983245Z","steps":["trace[915706957] 'count revisions from in-memory index tree' (duration: 767.835701ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:30.983307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:30.215163Z","time spent":"768.131935ms","remote":"127.0.0.1:52840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":26,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-24T17:24:30.983787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.324117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:87 size:64784"} {"level":"info","ts":"2026-07-24T17:24:30.983869Z","caller":"traceutil/trace.go:171","msg":"trace[1173075641] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:87; response_revision:1481; }","duration":"779.424998ms","start":"2026-07-24T17:24:30.204426Z","end":"2026-07-24T17:24:30.983851Z","steps":["trace[1173075641] 'range keys from in-memory index tree' (duration: 778.853663ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:30.983919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:30.204396Z","time spent":"779.51024ms","remote":"127.0.0.1:44136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":87,"response size":64805,"request content":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 "} {"level":"warn","ts":"2026-07-24T17:24:30.984106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.456278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:87 size:64784"} {"level":"info","ts":"2026-07-24T17:24:30.984198Z","caller":"traceutil/trace.go:171","msg":"trace[1157529844] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:87; response_revision:1481; }","duration":"757.582229ms","start":"2026-07-24T17:24:30.226598Z","end":"2026-07-24T17:24:30.98418Z","steps":["trace[1157529844] 'range keys from in-memory index tree' (duration: 756.638599ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:30.984247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:30.22659Z","time spent":"757.640469ms","remote":"127.0.0.1:44136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":87,"response size":64805,"request content":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 "} {"level":"info","ts":"2026-07-24T17:24:31.061453Z","caller":"traceutil/trace.go:171","msg":"trace[397159893] linearizableReadLoop","detail":"{readStateIndex:1544; appliedIndex:1543; }","duration":"439.476808ms","start":"2026-07-24T17:24:30.621957Z","end":"2026-07-24T17:24:31.061434Z","steps":["trace[397159893] 'read index received' (duration: 439.299756ms)","trace[397159893] 'applied index is now lower than readState.Index' (duration: 176.152µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:31.061605Z","caller":"traceutil/trace.go:171","msg":"trace[1528859680] transaction","detail":"{read_only:false; response_revision:1482; number_of_response:1; }","duration":"461.343078ms","start":"2026-07-24T17:24:30.6002Z","end":"2026-07-24T17:24:31.061543Z","steps":["trace[1528859680] 'process raft request' (duration: 461.105935ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:31.061647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.64684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-24T17:24:31.061686Z","caller":"traceutil/trace.go:171","msg":"trace[484084730] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1482; }","duration":"439.72681ms","start":"2026-07-24T17:24:30.621951Z","end":"2026-07-24T17:24:31.061677Z","steps":["trace[484084730] 'agreement among raft nodes before linearized reading' (duration: 439.594099ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:31.061713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:30.621892Z","time spent":"439.814173ms","remote":"127.0.0.1:44498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":28,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-07-24T17:24:31.061781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:30.600172Z","time spent":"461.51569ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:24:31.196091Z","caller":"traceutil/trace.go:171","msg":"trace[1448256386] linearizableReadLoop","detail":"{readStateIndex:1545; appliedIndex:1544; }","duration":"124.294453ms","start":"2026-07-24T17:24:31.071765Z","end":"2026-07-24T17:24:31.196059Z","steps":["trace[1448256386] 'read index received' (duration: 31.681962ms)","trace[1448256386] 'applied index is now lower than readState.Index' (duration: 92.611031ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:31.196255Z","caller":"traceutil/trace.go:171","msg":"trace[292797531] transaction","detail":"{read_only:false; response_revision:1483; number_of_response:1; }","duration":"131.618175ms","start":"2026-07-24T17:24:31.064623Z","end":"2026-07-24T17:24:31.196241Z","steps":["trace[292797531] 'process raft request' (duration: 38.886052ms)","trace[292797531] 'compare' (duration: 92.407658ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:31.196398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.646145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/default\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-07-24T17:24:31.196444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.656348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/sh.helm.release.v1.local-path-provisioner.v1\" ","response":"range_response_count:1 size:12755"} {"level":"info","ts":"2026-07-24T17:24:31.196483Z","caller":"traceutil/trace.go:171","msg":"trace[163294882] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/default; range_end:; response_count:1; response_revision:1483; }","duration":"122.764836ms","start":"2026-07-24T17:24:31.073698Z","end":"2026-07-24T17:24:31.196462Z","steps":["trace[163294882] 'agreement among raft nodes before linearized reading' (duration: 122.559814ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:31.196516Z","caller":"traceutil/trace.go:171","msg":"trace[1609402404] range","detail":"{range_begin:/registry/secrets/local-path-storage/sh.helm.release.v1.local-path-provisioner.v1; range_end:; response_count:1; response_revision:1483; }","duration":"124.766538ms","start":"2026-07-24T17:24:31.07173Z","end":"2026-07-24T17:24:31.196497Z","steps":["trace[1609402404] 'agreement among raft nodes before linearized reading' (duration: 124.545976ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:31.62747Z","caller":"traceutil/trace.go:171","msg":"trace[492151505] linearizableReadLoop","detail":"{readStateIndex:1546; appliedIndex:1545; }","duration":"349.996994ms","start":"2026-07-24T17:24:31.277448Z","end":"2026-07-24T17:24:31.627445Z","steps":["trace[492151505] 'read index received' (duration: 287.134235ms)","trace[492151505] 'applied index is now lower than readState.Index' (duration: 62.861749ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:31.627752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.441146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/sh.helm.release.v1.local-path-provisioner.v1\" ","response":"range_response_count:1 size:12755"} {"level":"warn","ts":"2026-07-24T17:24:31.627738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.266708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/default\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-07-24T17:24:31.627759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.388017ms","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-24T17:24:31.6278Z","caller":"traceutil/trace.go:171","msg":"trace[2035267916] range","detail":"{range_begin:/registry/secrets/local-path-storage/sh.helm.release.v1.local-path-provisioner.v1; range_end:; response_count:1; response_revision:1484; }","duration":"347.542237ms","start":"2026-07-24T17:24:31.280241Z","end":"2026-07-24T17:24:31.627784Z","steps":["trace[2035267916] 'agreement among raft nodes before linearized reading' (duration: 347.364496ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:31.627818Z","caller":"traceutil/trace.go:171","msg":"trace[169201191] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/default; range_end:; response_count:1; response_revision:1484; }","duration":"350.394949ms","start":"2026-07-24T17:24:31.277407Z","end":"2026-07-24T17:24:31.627802Z","steps":["trace[169201191] 'agreement among raft nodes before linearized reading' (duration: 350.150005ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:31.627839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:31.280226Z","time spent":"347.603918ms","remote":"127.0.0.1:44152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":12776,"request content":"key:\"/registry/secrets/local-path-storage/sh.helm.release.v1.local-path-provisioner.v1\" "} {"level":"info","ts":"2026-07-24T17:24:31.627839Z","caller":"traceutil/trace.go:171","msg":"trace[162777025] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1484; }","duration":"241.518368ms","start":"2026-07-24T17:24:31.386297Z","end":"2026-07-24T17:24:31.627815Z","steps":["trace[162777025] 'agreement among raft nodes before linearized reading' (duration: 241.318946ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:31.627867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:31.27739Z","time spent":"350.46757ms","remote":"127.0.0.1:44244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":214,"request content":"key:\"/registry/serviceaccounts/local-path-storage/default\" "} {"level":"info","ts":"2026-07-24T17:24:31.627535Z","caller":"traceutil/trace.go:171","msg":"trace[1259954682] transaction","detail":"{read_only:false; response_revision:1484; number_of_response:1; }","duration":"427.121592ms","start":"2026-07-24T17:24:31.200338Z","end":"2026-07-24T17:24:31.62746Z","steps":["trace[1259954682] 'process raft request' (duration: 364.319333ms)","trace[1259954682] 'compare' (duration: 62.690218ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:31.628274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:31.200316Z","time spent":"427.893121ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:24:32.217469Z","caller":"traceutil/trace.go:171","msg":"trace[182302173] transaction","detail":"{read_only:false; response_revision:1487; number_of_response:1; }","duration":"327.079864ms","start":"2026-07-24T17:24:31.89036Z","end":"2026-07-24T17:24:32.21744Z","steps":["trace[182302173] 'process raft request' (duration: 230.010438ms)","trace[182302173] 'compare' (duration: 96.973705ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:32.217624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:31.890345Z","time spent":"327.191125ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:24:33.963794Z","caller":"traceutil/trace.go:171","msg":"trace[1043633920] linearizableReadLoop","detail":"{readStateIndex:1552; appliedIndex:1551; }","duration":"275.637634ms","start":"2026-07-24T17:24:33.688134Z","end":"2026-07-24T17:24:33.963772Z","steps":["trace[1043633920] 'read index received' (duration: 275.451822ms)","trace[1043633920] 'applied index is now lower than readState.Index' (duration: 184.962µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:33.963855Z","caller":"traceutil/trace.go:171","msg":"trace[2028178384] transaction","detail":"{read_only:false; response_revision:1490; number_of_response:1; }","duration":"326.235933ms","start":"2026-07-24T17:24:33.637595Z","end":"2026-07-24T17:24:33.963831Z","steps":["trace[2028178384] 'process raft request' (duration: 326.049091ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:33.963987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:33.637578Z","time spent":"326.325075ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:24:33.964017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.873647ms","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-24T17:24:33.964051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.952366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/\" range_end:\"/registry/pods/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:24:33.964093Z","caller":"traceutil/trace.go:171","msg":"trace[2055852537] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1490; }","duration":"275.983599ms","start":"2026-07-24T17:24:33.688095Z","end":"2026-07-24T17:24:33.964079Z","steps":["trace[2055852537] 'agreement among raft nodes before linearized reading' (duration: 275.806627ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:33.96413Z","caller":"traceutil/trace.go:171","msg":"trace[1962400662] range","detail":"{range_begin:/registry/pods/default/; range_end:/registry/pods/default0; response_count:0; response_revision:1490; }","duration":"268.077328ms","start":"2026-07-24T17:24:33.696035Z","end":"2026-07-24T17:24:33.964113Z","steps":["trace[1962400662] 'agreement among raft nodes before linearized reading' (duration: 267.950637ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:33.964198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.072306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:24:33.964288Z","caller":"traceutil/trace.go:171","msg":"trace[449758927] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1490; }","duration":"142.218218ms","start":"2026-07-24T17:24:33.82205Z","end":"2026-07-24T17:24:33.964269Z","steps":["trace[449758927] 'agreement among raft nodes before linearized reading' (duration: 142.042766ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:34.155589Z","caller":"traceutil/trace.go:171","msg":"trace[2107622336] linearizableReadLoop","detail":"{readStateIndex:1554; appliedIndex:1553; }","duration":"112.347503ms","start":"2026-07-24T17:24:34.043209Z","end":"2026-07-24T17:24:34.155557Z","steps":["trace[2107622336] 'read index received' (duration: 68.353442ms)","trace[2107622336] 'applied index is now lower than readState.Index' (duration: 43.992371ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:34.155715Z","caller":"traceutil/trace.go:171","msg":"trace[1260739420] transaction","detail":"{read_only:false; response_revision:1492; number_of_response:1; }","duration":"186.331837ms","start":"2026-07-24T17:24:33.969346Z","end":"2026-07-24T17:24:34.155678Z","steps":["trace[1260739420] 'process raft request' (duration: 142.253096ms)","trace[1260739420] 'compare' (duration: 43.792258ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:34.155972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.724007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/\" range_end:\"/registry/pods/envoy-gateway-system0\" limit:500 ","response":"range_response_count:1 size:5487"} {"level":"info","ts":"2026-07-24T17:24:34.156035Z","caller":"traceutil/trace.go:171","msg":"trace[1142506250] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/; range_end:/registry/pods/envoy-gateway-system0; response_count:1; response_revision:1492; }","duration":"112.848468ms","start":"2026-07-24T17:24:34.04317Z","end":"2026-07-24T17:24:34.156018Z","steps":["trace[1142506250] 'agreement among raft nodes before linearized reading' (duration: 112.573065ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:34.343801Z","caller":"traceutil/trace.go:171","msg":"trace[612462432] transaction","detail":"{read_only:false; response_revision:1493; number_of_response:1; }","duration":"119.140891ms","start":"2026-07-24T17:24:34.224637Z","end":"2026-07-24T17:24:34.343777Z","steps":["trace[612462432] 'process raft request' (duration: 119.02714ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:34.344119Z","caller":"traceutil/trace.go:171","msg":"trace[1913764884] linearizableReadLoop","detail":"{readStateIndex:1555; appliedIndex:1554; }","duration":"123.191748ms","start":"2026-07-24T17:24:34.220888Z","end":"2026-07-24T17:24:34.34408Z","steps":["trace[1913764884] 'read index received' (duration: 47.336639ms)","trace[1913764884] 'applied index is now lower than readState.Index' (duration: 75.848599ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:34.344394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.491183ms","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-24T17:24:34.344436Z","caller":"traceutil/trace.go:171","msg":"trace[293409413] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1493; }","duration":"123.591603ms","start":"2026-07-24T17:24:34.220832Z","end":"2026-07-24T17:24:34.344424Z","steps":["trace[293409413] 'agreement among raft nodes before linearized reading' (duration: 123.443452ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:34.845041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.671869ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-24T17:24:34.845153Z","caller":"traceutil/trace.go:171","msg":"trace[1114003567] linearizableReadLoop","detail":"{readStateIndex:1558; appliedIndex:1556; }","duration":"422.084017ms","start":"2026-07-24T17:24:34.423053Z","end":"2026-07-24T17:24:34.845137Z","steps":["trace[1114003567] 'read index received' (duration: 6.349935ms)","trace[1114003567] 'applied index is now lower than readState.Index' (duration: 415.733082ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:34.845242Z","caller":"traceutil/trace.go:171","msg":"trace[1999092516] transaction","detail":"{read_only:false; response_revision:1495; number_of_response:1; }","duration":"495.883202ms","start":"2026-07-24T17:24:34.349348Z","end":"2026-07-24T17:24:34.845231Z","steps":["trace[1999092516] 'process raft request' (duration: 231.94071ms)","trace[1999092516] 'compare' (duration: 263.530977ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:34.845305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:34.349298Z","time spent":"495.975853ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:24:34.845682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.620153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-public/\" range_end:\"/registry/pods/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:24:34.845745Z","caller":"traceutil/trace.go:171","msg":"trace[989314297] range","detail":"{range_begin:/registry/pods/kube-public/; range_end:/registry/pods/kube-public0; response_count:0; response_revision:1495; }","duration":"422.711573ms","start":"2026-07-24T17:24:34.423017Z","end":"2026-07-24T17:24:34.845728Z","steps":["trace[989314297] 'agreement among raft nodes before linearized reading' (duration: 422.635142ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:34.845781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:34.422995Z","time spent":"422.776744ms","remote":"127.0.0.1:44228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":0,"response size":26,"request content":"key:\"/registry/pods/kube-public/\" range_end:\"/registry/pods/kube-public0\" limit:500 "} {"level":"warn","ts":"2026-07-24T17:24:34.846026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.336293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-vcnqk\" ","response":"range_response_count:1 size:5487"} {"level":"info","ts":"2026-07-24T17:24:34.84608Z","caller":"traceutil/trace.go:171","msg":"trace[1792242920] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-vcnqk; range_end:; response_count:1; response_revision:1495; }","duration":"413.412515ms","start":"2026-07-24T17:24:34.432652Z","end":"2026-07-24T17:24:34.846065Z","steps":["trace[1792242920] 'agreement among raft nodes before linearized reading' (duration: 413.219893ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:34.845351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.842041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"warn","ts":"2026-07-24T17:24:34.846114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:34.432642Z","time spent":"413.464436ms","remote":"127.0.0.1:44228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":1,"response size":5508,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-vcnqk\" "} {"level":"info","ts":"2026-07-24T17:24:34.846296Z","caller":"traceutil/trace.go:171","msg":"trace[1141328191] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1495; }","duration":"414.66867ms","start":"2026-07-24T17:24:34.431458Z","end":"2026-07-24T17:24:34.846127Z","steps":["trace[1141328191] 'agreement among raft nodes before linearized reading' (duration: 413.81966ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:34.846376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:34.431446Z","time spent":"414.918343ms","remote":"127.0.0.1:44214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":443,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"info","ts":"2026-07-24T17:24:35.588455Z","caller":"traceutil/trace.go:171","msg":"trace[8327590] linearizableReadLoop","detail":"{readStateIndex:1559; appliedIndex:1558; }","duration":"291.065791ms","start":"2026-07-24T17:24:35.297344Z","end":"2026-07-24T17:24:35.58841Z","steps":["trace[8327590] 'read index received' (duration: 290.787828ms)","trace[8327590] 'applied index is now lower than readState.Index' (duration: 277.093µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:35.588583Z","caller":"traceutil/trace.go:171","msg":"trace[1253772913] transaction","detail":"{read_only:false; response_revision:1496; number_of_response:1; }","duration":"303.939092ms","start":"2026-07-24T17:24:35.284589Z","end":"2026-07-24T17:24:35.588529Z","steps":["trace[1253772913] 'process raft request' (duration: 303.642709ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:35.588722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.353205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-k7qhd\" ","response":"range_response_count:1 size:18525"} {"level":"info","ts":"2026-07-24T17:24:35.588756Z","caller":"traceutil/trace.go:171","msg":"trace[1106268219] range","detail":"{range_begin:/registry/pods/kube-system/cilium-k7qhd; range_end:; response_count:1; response_revision:1496; }","duration":"291.432067ms","start":"2026-07-24T17:24:35.297314Z","end":"2026-07-24T17:24:35.588746Z","steps":["trace[1106268219] 'agreement among raft nodes before linearized reading' (duration: 291.266894ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:35.588774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.658638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-24T17:24:35.588871Z","caller":"traceutil/trace.go:171","msg":"trace[523169257] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1496; }","duration":"251.78093ms","start":"2026-07-24T17:24:35.337066Z","end":"2026-07-24T17:24:35.588847Z","steps":["trace[523169257] 'agreement among raft nodes before linearized reading' (duration: 251.589177ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:35.588937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:35.284565Z","time spent":"304.191806ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:24:36.221197Z","caller":"traceutil/trace.go:171","msg":"trace[1456336443] linearizableReadLoop","detail":"{readStateIndex:1561; appliedIndex:1560; }","duration":"166.368871ms","start":"2026-07-24T17:24:36.054801Z","end":"2026-07-24T17:24:36.22117Z","steps":["trace[1456336443] 'read index received' (duration: 122.364138ms)","trace[1456336443] 'applied index is now lower than readState.Index' (duration: 44.003533ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:36.221375Z","caller":"traceutil/trace.go:171","msg":"trace[2082101979] transaction","detail":"{read_only:false; response_revision:1498; number_of_response:1; }","duration":"168.82278ms","start":"2026-07-24T17:24:36.052521Z","end":"2026-07-24T17:24:36.221344Z","steps":["trace[2082101979] 'process raft request' (duration: 124.704116ms)","trace[2082101979] 'compare' (duration: 43.828211ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:36.221577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.737265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-k7qhd\" ","response":"range_response_count:1 size:18525"} {"level":"info","ts":"2026-07-24T17:24:36.221674Z","caller":"traceutil/trace.go:171","msg":"trace[1613186971] range","detail":"{range_begin:/registry/pods/kube-system/cilium-k7qhd; range_end:; response_count:1; response_revision:1498; }","duration":"166.872127ms","start":"2026-07-24T17:24:36.054779Z","end":"2026-07-24T17:24:36.221651Z","steps":["trace[1613186971] 'agreement among raft nodes before linearized reading' (duration: 166.591894ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:36.563449Z","caller":"traceutil/trace.go:171","msg":"trace[1179354779] linearizableReadLoop","detail":"{readStateIndex:1563; appliedIndex:1562; }","duration":"152.505246ms","start":"2026-07-24T17:24:36.410898Z","end":"2026-07-24T17:24:36.563403Z","steps":["trace[1179354779] 'read index received' (duration: 112.58323ms)","trace[1179354779] 'applied index is now lower than readState.Index' (duration: 39.920236ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:36.563799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.8615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-k7qhd\" ","response":"range_response_count:1 size:18525"} {"level":"info","ts":"2026-07-24T17:24:36.563849Z","caller":"traceutil/trace.go:171","msg":"trace[1756851436] range","detail":"{range_begin:/registry/pods/kube-system/cilium-k7qhd; range_end:; response_count:1; response_revision:1500; }","duration":"152.982182ms","start":"2026-07-24T17:24:36.410853Z","end":"2026-07-24T17:24:36.563835Z","steps":["trace[1756851436] 'agreement among raft nodes before linearized reading' (duration: 152.706019ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:36.563812Z","caller":"traceutil/trace.go:171","msg":"trace[520544776] transaction","detail":"{read_only:false; response_revision:1500; number_of_response:1; }","duration":"214.361123ms","start":"2026-07-24T17:24:36.349404Z","end":"2026-07-24T17:24:36.563765Z","steps":["trace[520544776] 'process raft request' (duration: 174.058712ms)","trace[520544776] 'compare' (duration: 39.738453ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:37.181917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.655034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:24:37.18202Z","caller":"traceutil/trace.go:171","msg":"trace[1398171172] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1501; }","duration":"129.777975ms","start":"2026-07-24T17:24:37.052218Z","end":"2026-07-24T17:24:37.181995Z","steps":["trace[1398171172] 'count revisions from in-memory index tree' (duration: 129.574542ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:37.182063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.519449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-k7qhd\" ","response":"range_response_count:1 size:18525"} {"level":"info","ts":"2026-07-24T17:24:37.182118Z","caller":"traceutil/trace.go:171","msg":"trace[612448474] range","detail":"{range_begin:/registry/pods/kube-system/cilium-k7qhd; range_end:; response_count:1; response_revision:1501; }","duration":"223.614771ms","start":"2026-07-24T17:24:36.958487Z","end":"2026-07-24T17:24:37.182102Z","steps":["trace[612448474] 'range keys from in-memory index tree' (duration: 223.311436ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:37.907461Z","caller":"traceutil/trace.go:171","msg":"trace[1554601950] transaction","detail":"{read_only:false; response_revision:1502; number_of_response:1; }","duration":"308.118707ms","start":"2026-07-24T17:24:37.599317Z","end":"2026-07-24T17:24:37.907436Z","steps":["trace[1554601950] 'process raft request' (duration: 307.961545ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:37.907616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:37.599294Z","time spent":"308.243318ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:24:37.90792Z","caller":"traceutil/trace.go:171","msg":"trace[309578394] linearizableReadLoop","detail":"{readStateIndex:1565; appliedIndex:1565; }","duration":"308.537391ms","start":"2026-07-24T17:24:37.599371Z","end":"2026-07-24T17:24:37.907908Z","steps":["trace[309578394] 'read index received' (duration: 308.530631ms)","trace[309578394] 'applied index is now lower than readState.Index' (duration: 5.73µs)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:37.908086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.706283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-j24zz\" ","response":"range_response_count:1 size:4694"} {"level":"info","ts":"2026-07-24T17:24:37.908119Z","caller":"traceutil/trace.go:171","msg":"trace[1185743907] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-j24zz; range_end:; response_count:1; response_revision:1502; }","duration":"308.752653ms","start":"2026-07-24T17:24:37.599355Z","end":"2026-07-24T17:24:37.908108Z","steps":["trace[1185743907] 'agreement among raft nodes before linearized reading' (duration: 308.633172ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:37.90815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:37.599348Z","time spent":"308.795474ms","remote":"127.0.0.1:44228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4715,"request content":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-j24zz\" "} {"level":"warn","ts":"2026-07-24T17:24:38.258704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.550742ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-24T17:24:38.25883Z","caller":"traceutil/trace.go:171","msg":"trace[486113300] linearizableReadLoop","detail":"{readStateIndex:1566; appliedIndex:1565; }","duration":"275.2929ms","start":"2026-07-24T17:24:37.983517Z","end":"2026-07-24T17:24:38.25881Z","steps":["trace[486113300] 'read index received' (duration: 37.566346ms)","trace[486113300] 'applied index is now lower than readState.Index' (duration: 237.722104ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:38.258863Z","caller":"traceutil/trace.go:171","msg":"trace[761709831] transaction","detail":"{read_only:false; response_revision:1503; number_of_response:1; }","duration":"368.120669ms","start":"2026-07-24T17:24:37.890712Z","end":"2026-07-24T17:24:38.258832Z","steps":["trace[761709831] 'process raft request' (duration: 130.356775ms)","trace[761709831] 'compare' (duration: 237.44628ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:38.258987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:24:37.890686Z","time spent":"368.242451ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:24:38.259061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.056479ms","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-24T17:24:38.259114Z","caller":"traceutil/trace.go:171","msg":"trace[1081328243] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1503; }","duration":"207.15614ms","start":"2026-07-24T17:24:38.051943Z","end":"2026-07-24T17:24:38.259099Z","steps":["trace[1081328243] 'agreement among raft nodes before linearized reading' (duration: 207.000498ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:38.259571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.575083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-j24zz\" ","response":"range_response_count:1 size:4694"} {"level":"info","ts":"2026-07-24T17:24:38.259737Z","caller":"traceutil/trace.go:171","msg":"trace[2145456170] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-j24zz; range_end:; response_count:1; response_revision:1503; }","duration":"276.238062ms","start":"2026-07-24T17:24:37.983481Z","end":"2026-07-24T17:24:38.259719Z","steps":["trace[2145456170] 'agreement among raft nodes before linearized reading' (duration: 275.451232ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:38.467689Z","caller":"traceutil/trace.go:171","msg":"trace[17920958] transaction","detail":"{read_only:false; response_revision:1505; number_of_response:1; }","duration":"203.032249ms","start":"2026-07-24T17:24:38.264638Z","end":"2026-07-24T17:24:38.467671Z","steps":["trace[17920958] 'process raft request' (duration: 177.692149ms)","trace[17920958] 'compare' (duration: 25.215728ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:38.467682Z","caller":"traceutil/trace.go:171","msg":"trace[431538876] linearizableReadLoop","detail":"{readStateIndex:1568; appliedIndex:1566; }","duration":"200.64724ms","start":"2026-07-24T17:24:38.267005Z","end":"2026-07-24T17:24:38.467652Z","steps":["trace[431538876] 'read index received' (duration: 80.122048ms)","trace[431538876] 'applied index is now lower than readState.Index' (duration: 120.524262ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:38.467988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.915791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-24T17:24:38.468022Z","caller":"traceutil/trace.go:171","msg":"trace[1142254129] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1505; }","duration":"173.007482ms","start":"2026-07-24T17:24:38.295006Z","end":"2026-07-24T17:24:38.468013Z","steps":["trace[1142254129] 'agreement among raft nodes before linearized reading' (duration: 172.891401ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:38.468009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.853448ms","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-24T17:24:38.46809Z","caller":"traceutil/trace.go:171","msg":"trace[296249865] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1505; }","duration":"189.961389ms","start":"2026-07-24T17:24:38.278111Z","end":"2026-07-24T17:24:38.468072Z","steps":["trace[296249865] 'agreement among raft nodes before linearized reading' (duration: 189.750266ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:38.468178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.108405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-j24zz\" ","response":"range_response_count:1 size:4694"} {"level":"info","ts":"2026-07-24T17:24:38.468293Z","caller":"traceutil/trace.go:171","msg":"trace[1433003288] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-j24zz; range_end:; response_count:1; response_revision:1505; }","duration":"201.280147ms","start":"2026-07-24T17:24:38.266999Z","end":"2026-07-24T17:24:38.468279Z","steps":["trace[1433003288] 'agreement among raft nodes before linearized reading' (duration: 200.727131ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:38.755129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.027265ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-24T17:24:38.75526Z","caller":"traceutil/trace.go:171","msg":"trace[586285046] linearizableReadLoop","detail":"{readStateIndex:1570; appliedIndex:1569; }","duration":"119.169316ms","start":"2026-07-24T17:24:38.636072Z","end":"2026-07-24T17:24:38.755241Z","steps":["trace[586285046] 'read index received' (duration: 12.891958ms)","trace[586285046] 'applied index is now lower than readState.Index' (duration: 106.275948ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:38.755325Z","caller":"traceutil/trace.go:171","msg":"trace[692146162] transaction","detail":"{read_only:false; response_revision:1507; number_of_response:1; }","duration":"187.262427ms","start":"2026-07-24T17:24:38.568013Z","end":"2026-07-24T17:24:38.755275Z","steps":["trace[692146162] 'process raft request' (duration: 80.996859ms)","trace[692146162] 'compare' (duration: 105.906523ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:38.755549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.458089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-srpmm\" ","response":"range_response_count:1 size:4905"} {"level":"info","ts":"2026-07-24T17:24:38.755667Z","caller":"traceutil/trace.go:171","msg":"trace[315779038] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-srpmm; range_end:; response_count:1; response_revision:1507; }","duration":"119.616351ms","start":"2026-07-24T17:24:38.636031Z","end":"2026-07-24T17:24:38.755647Z","steps":["trace[315779038] 'agreement among raft nodes before linearized reading' (duration: 119.287617ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:24:39.166467Z","caller":"traceutil/trace.go:171","msg":"trace[1293540247] linearizableReadLoop","detail":"{readStateIndex:1571; appliedIndex:1570; }","duration":"165.176362ms","start":"2026-07-24T17:24:39.001267Z","end":"2026-07-24T17:24:39.166443Z","steps":["trace[1293540247] 'read index received' (duration: 164.940489ms)","trace[1293540247] 'applied index is now lower than readState.Index' (duration: 234.763µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:24:39.166545Z","caller":"traceutil/trace.go:171","msg":"trace[836188489] transaction","detail":"{read_only:false; response_revision:1508; number_of_response:1; }","duration":"210.255642ms","start":"2026-07-24T17:24:38.956234Z","end":"2026-07-24T17:24:39.166489Z","steps":["trace[836188489] 'process raft request' (duration: 210.003249ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:39.166652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.363704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-srpmm\" ","response":"range_response_count:1 size:4905"} {"level":"info","ts":"2026-07-24T17:24:39.166684Z","caller":"traceutil/trace.go:171","msg":"trace[566857192] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-srpmm; range_end:; response_count:1; response_revision:1508; }","duration":"165.443425ms","start":"2026-07-24T17:24:39.001231Z","end":"2026-07-24T17:24:39.166675Z","steps":["trace[566857192] 'agreement among raft nodes before linearized reading' (duration: 165.302123ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:39.374601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.734422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-wzrng\" ","response":"range_response_count:1 size:4905"} {"level":"info","ts":"2026-07-24T17:24:39.374683Z","caller":"traceutil/trace.go:171","msg":"trace[46963081] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-wzrng; range_end:; response_count:1; response_revision:1508; }","duration":"124.874374ms","start":"2026-07-24T17:24:39.249791Z","end":"2026-07-24T17:24:39.374665Z","steps":["trace[46963081] 'range keys from in-memory index tree' (duration: 124.56482ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:24:39.733176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.025716ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:26"} {"level":"info","ts":"2026-07-24T17:24:39.733272Z","caller":"traceutil/trace.go:171","msg":"trace[1552813106] linearizableReadLoop","detail":"{readStateIndex:1572; appliedIndex:1571; }","duration":"283.771958ms","start":"2026-07-24T17:24:39.449485Z","end":"2026-07-24T17:24:39.733257Z","steps":["trace[1552813106] 'read index received' (duration: 82.658231ms)","trace[1552813106] 'applied index is now lower than readState.Index' (duration: 201.112457ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:24:39.73342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.92392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-wzrng\" ","response":"range_response_count:1 size:4905"} {"level":"info","ts":"2026-07-24T17:24:39.733454Z","caller":"traceutil/trace.go:171","msg":"trace[1200443419] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-wzrng; range_end:; response_count:1; response_revision:1508; }","duration":"284.00117ms","start":"2026-07-24T17:24:39.449444Z","end":"2026-07-24T17:24:39.733445Z","steps":["trace[1200443419] 'agreement among raft nodes before linearized reading' (duration: 283.857458ms)"],"step_count":1}