{"level":"warn","ts":"2026-05-26T15:48:38.019823Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T15:48:38.019949Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.153:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.153:2380","--initial-cluster=instance=https://199.19.213.153:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.153:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.153: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-05-26T15:48:38.020049Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T15:48:38.020067Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.153:2380"]} {"level":"info","ts":"2026-05-26T15:48:38.020278Z","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-05-26T15:48:38.021175Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.153:2379"]} {"level":"info","ts":"2026-05-26T15:48:38.021286Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.153:2380"],"listen-peer-urls":["https://199.19.213.153:2380"],"advertise-client-urls":["https://199.19.213.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.153: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-05-26T15:48:38.026374Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.842554ms"} {"level":"info","ts":"2026-05-26T15:48:38.034534Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"36b63984d68b7065","cluster-id":"7c251967b436417d"} {"level":"info","ts":"2026-05-26T15:48:38.034627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 switched to configuration voters=()"} {"level":"info","ts":"2026-05-26T15:48:38.03465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 became follower at term 0"} {"level":"info","ts":"2026-05-26T15:48:38.03466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 36b63984d68b7065 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-26T15:48:38.03467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 became follower at term 1"} {"level":"info","ts":"2026-05-26T15:48:38.034714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 switched to configuration voters=(3942401766507376741)"} {"level":"warn","ts":"2026-05-26T15:48:38.04503Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-26T15:48:38.049139Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-26T15:48:38.063761Z","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-05-26T15:48:38.074485Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"36b63984d68b7065","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-26T15:48:38.074593Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"36b63984d68b7065","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-26T15:48:38.074861Z","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-05-26T15:48:38.074944Z","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-05-26T15:48:38.074961Z","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-05-26T15:48:38.080813Z","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-05-26T15:48:38.080996Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.153:2380"} {"level":"info","ts":"2026-05-26T15:48:38.081059Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.153:2380"} {"level":"info","ts":"2026-05-26T15:48:38.081176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 switched to configuration voters=(3942401766507376741)"} {"level":"info","ts":"2026-05-26T15:48:38.081327Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7c251967b436417d","local-member-id":"36b63984d68b7065","added-peer-id":"36b63984d68b7065","added-peer-peer-urls":["https://199.19.213.153:2380"]} {"level":"info","ts":"2026-05-26T15:48:38.081482Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"36b63984d68b7065","initial-advertise-peer-urls":["https://199.19.213.153:2380"],"listen-peer-urls":["https://199.19.213.153:2380"],"advertise-client-urls":["https://199.19.213.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-26T15:48:38.081545Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-26T15:48:38.935559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 is starting a new election at term 1"} {"level":"info","ts":"2026-05-26T15:48:38.935635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-26T15:48:38.93568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 received MsgPreVoteResp from 36b63984d68b7065 at term 1"} {"level":"info","ts":"2026-05-26T15:48:38.935706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 became candidate at term 2"} {"level":"info","ts":"2026-05-26T15:48:38.935722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 received MsgVoteResp from 36b63984d68b7065 at term 2"} {"level":"info","ts":"2026-05-26T15:48:38.935739Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36b63984d68b7065 became leader at term 2"} {"level":"info","ts":"2026-05-26T15:48:38.935752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 36b63984d68b7065 elected leader 36b63984d68b7065 at term 2"} {"level":"info","ts":"2026-05-26T15:48:38.9369Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"36b63984d68b7065","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.153:2379]}","request-path":"/0/members/36b63984d68b7065/attributes","cluster-id":"7c251967b436417d","publish-timeout":"7s"} {"level":"info","ts":"2026-05-26T15:48:38.936936Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T15:48:38.936958Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T15:48:38.937018Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T15:48:38.937214Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-26T15:48:38.93739Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-26T15:48:38.937965Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7c251967b436417d","local-member-id":"36b63984d68b7065","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T15:48:38.938032Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T15:48:38.938125Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T15:48:38.940055Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-26T15:48:38.941624Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.153:2379"} {"level":"info","ts":"2026-05-26T15:49:21.750365Z","caller":"traceutil/trace.go:171","msg":"trace[755287451] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"212.052412ms","start":"2026-05-26T15:49:21.538281Z","end":"2026-05-26T15:49:21.750333Z","steps":["trace[755287451] 'process raft request' (duration: 144.522324ms)","trace[755287451] 'compare' (duration: 67.369613ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:49:22.208291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.316311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.153\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-26T15:49:22.208407Z","caller":"traceutil/trace.go:171","msg":"trace[514036844] range","detail":"{range_begin:/registry/masterleases/199.19.213.153; range_end:; response_count:1; response_revision:633; }","duration":"222.492217ms","start":"2026-05-26T15:49:21.985897Z","end":"2026-05-26T15:49:22.208389Z","steps":["trace[514036844] 'range keys from in-memory index tree' (duration: 222.154717ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:49:22.208512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.789829ms","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-05-26T15:49:22.208596Z","caller":"traceutil/trace.go:171","msg":"trace[1406241925] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:633; }","duration":"189.940273ms","start":"2026-05-26T15:49:22.018636Z","end":"2026-05-26T15:49:22.208577Z","steps":["trace[1406241925] 'range keys from in-memory index tree' (duration: 189.613533ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:49:22.208666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.842769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bdx9q\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-26T15:49:22.208752Z","caller":"traceutil/trace.go:171","msg":"trace[45877505] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bdx9q; range_end:; response_count:1; response_revision:633; }","duration":"346.961333ms","start":"2026-05-26T15:49:21.86176Z","end":"2026-05-26T15:49:22.208722Z","steps":["trace[45877505] 'range keys from in-memory index tree' (duration: 346.580412ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:49:22.20879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:49:21.861745Z","time spent":"347.037146ms","remote":"127.0.0.1:60606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-bdx9q\" "} {"level":"warn","ts":"2026-05-26T15:49:22.822765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.075806ms","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-05-26T15:49:22.822929Z","caller":"traceutil/trace.go:171","msg":"trace[856175435] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:634; }","duration":"444.275252ms","start":"2026-05-26T15:49:22.378632Z","end":"2026-05-26T15:49:22.822907Z","steps":["trace[856175435] 'range keys from in-memory index tree' (duration: 444.052586ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:49:22.824185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.357261ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-05-26T15:49:22.824704Z","caller":"traceutil/trace.go:171","msg":"trace[70871369] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:657; }","duration":"600.099604ms","start":"2026-05-26T15:49:22.224566Z","end":"2026-05-26T15:49:22.824666Z","steps":["trace[70871369] 'read index received' (duration: 329.018892ms)","trace[70871369] 'applied index is now lower than readState.Index' (duration: 271.078512ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:49:22.825027Z","caller":"traceutil/trace.go:171","msg":"trace[117717517] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"601.946479ms","start":"2026-05-26T15:49:22.223063Z","end":"2026-05-26T15:49:22.82501Z","steps":["trace[117717517] 'process raft request' (duration: 601.503916ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:49:22.825303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:49:22.209934Z","time spent":"615.354322ms","remote":"127.0.0.1:60470","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-26T15:49:22.825559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.981269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:49:22.825605Z","caller":"traceutil/trace.go:171","msg":"trace[1297456383] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"601.053242ms","start":"2026-05-26T15:49:22.224541Z","end":"2026-05-26T15:49:22.825594Z","steps":["trace[1297456383] 'agreement among raft nodes before linearized reading' (duration: 600.555868ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:49:22.825665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.161299ms","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-05-26T15:49:22.825707Z","caller":"traceutil/trace.go:171","msg":"trace[119123985] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"537.544499ms","start":"2026-05-26T15:49:22.288121Z","end":"2026-05-26T15:49:22.825665Z","steps":["trace[119123985] 'process raft request' (duration: 536.499689ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:49:22.82584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.876636ms","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-05-26T15:49:22.825814Z","caller":"traceutil/trace.go:171","msg":"trace[126390763] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:637; }","duration":"217.341374ms","start":"2026-05-26T15:49:22.608407Z","end":"2026-05-26T15:49:22.825748Z","steps":["trace[126390763] 'agreement among raft nodes before linearized reading' (duration: 216.959653ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:49:22.825889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:49:22.2881Z","time spent":"537.687364ms","remote":"127.0.0.1:60670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T15:49:22.825751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:49:22.223024Z","time spent":"602.053212ms","remote":"127.0.0.1:60606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:49:22.825904Z","caller":"traceutil/trace.go:171","msg":"trace[1995333205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:637; }","duration":"149.989939ms","start":"2026-05-26T15:49:22.675892Z","end":"2026-05-26T15:49:22.825882Z","steps":["trace[1995333205] 'agreement among raft nodes before linearized reading' (duration: 149.810074ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:49:22.827649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:49:22.224531Z","time spent":"601.098293ms","remote":"127.0.0.1:60408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-26T15:49:22.829039Z","caller":"traceutil/trace.go:171","msg":"trace[2082978478] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"612.740205ms","start":"2026-05-26T15:49:22.212682Z","end":"2026-05-26T15:49:22.825422Z","steps":["trace[2082978478] 'process raft request' (duration: 611.724056ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:49:22.829196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:49:22.212662Z","time spent":"616.429403ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T15:50:52.539532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.318515ms","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-05-26T15:50:52.539659Z","caller":"traceutil/trace.go:171","msg":"trace[1311010187] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1873; }","duration":"161.457478ms","start":"2026-05-26T15:50:52.378184Z","end":"2026-05-26T15:50:52.539642Z","steps":["trace[1311010187] 'range keys from in-memory index tree' (duration: 161.303074ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:52.53981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.03511ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T15:50:52.54006Z","caller":"traceutil/trace.go:171","msg":"trace[1804126450] linearizableReadLoop","detail":"{readStateIndex:1945; appliedIndex:1943; }","duration":"431.604267ms","start":"2026-05-26T15:50:52.108427Z","end":"2026-05-26T15:50:52.540031Z","steps":["trace[1804126450] 'read index received' (duration: 96.288859ms)","trace[1804126450] 'applied index is now lower than readState.Index' (duration: 335.314478ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:50:52.540155Z","caller":"traceutil/trace.go:171","msg":"trace[1165672076] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"481.196527ms","start":"2026-05-26T15:50:52.058949Z","end":"2026-05-26T15:50:52.540145Z","steps":["trace[1165672076] 'process raft request' (duration: 480.977161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:52.540221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:50:52.058925Z","time spent":"481.261669ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:50:52.540259Z","caller":"traceutil/trace.go:171","msg":"trace[702702805] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"542.864668ms","start":"2026-05-26T15:50:51.997359Z","end":"2026-05-26T15:50:52.540223Z","steps":["trace[702702805] 'process raft request' (duration: 207.331494ms)","trace[702702805] 'compare' (duration: 334.776184ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:50:52.540499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.07782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-05-26T15:50:52.540504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:50:51.997346Z","time spent":"542.999422ms","remote":"127.0.0.1:60470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:50:52.540541Z","caller":"traceutil/trace.go:171","msg":"trace[200898553] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1875; }","duration":"432.153852ms","start":"2026-05-26T15:50:52.108377Z","end":"2026-05-26T15:50:52.54053Z","steps":["trace[200898553] 'agreement among raft nodes before linearized reading' (duration: 432.027399ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:52.540573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:50:52.108356Z","time spent":"432.207723ms","remote":"127.0.0.1:59198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-26T15:50:52.540738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.354958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-852edd15-2d48-4f66-9261-2be179381e99\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-26T15:50:52.540788Z","caller":"traceutil/trace.go:171","msg":"trace[1502270175] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-852edd15-2d48-4f66-9261-2be179381e99; range_end:; response_count:1; response_revision:1875; }","duration":"210.43794ms","start":"2026-05-26T15:50:52.330337Z","end":"2026-05-26T15:50:52.540775Z","steps":["trace[1502270175] 'agreement among raft nodes before linearized reading' (duration: 210.199884ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:52.540806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.398298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:50:52.541707Z","caller":"traceutil/trace.go:171","msg":"trace[1696248069] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1875; }","duration":"232.371447ms","start":"2026-05-26T15:50:52.30931Z","end":"2026-05-26T15:50:52.541682Z","steps":["trace[1696248069] 'agreement among raft nodes before linearized reading' (duration: 231.356528ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:52.54113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.398907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-26T15:50:52.541951Z","caller":"traceutil/trace.go:171","msg":"trace[1141401429] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1875; }","duration":"145.248811ms","start":"2026-05-26T15:50:52.396684Z","end":"2026-05-26T15:50:52.541933Z","steps":["trace[1141401429] 'agreement among raft nodes before linearized reading' (duration: 143.997796ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:52.541432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.644991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-852edd15-2d48-4f66-9261-2be179381e99\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-26T15:50:52.542104Z","caller":"traceutil/trace.go:171","msg":"trace[790874155] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-852edd15-2d48-4f66-9261-2be179381e99; range_end:; response_count:1; response_revision:1875; }","duration":"402.371471ms","start":"2026-05-26T15:50:52.139715Z","end":"2026-05-26T15:50:52.542087Z","steps":["trace[790874155] 'agreement among raft nodes before linearized reading' (duration: 400.758386ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:52.542243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:50:52.139692Z","time spent":"402.523314ms","remote":"127.0.0.1:60606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-852edd15-2d48-4f66-9261-2be179381e99\" "} {"level":"info","ts":"2026-05-26T15:50:53.477324Z","caller":"traceutil/trace.go:171","msg":"trace[230102355] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"930.463487ms","start":"2026-05-26T15:50:52.546833Z","end":"2026-05-26T15:50:53.477297Z","steps":["trace[230102355] 'process raft request' (duration: 855.120255ms)","trace[230102355] 'compare' (duration: 75.218019ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:50:53.477777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:50:52.546816Z","time spent":"930.57661ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:50:53.509541Z","caller":"traceutil/trace.go:171","msg":"trace[1842360695] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"959.50293ms","start":"2026-05-26T15:50:52.55002Z","end":"2026-05-26T15:50:53.509523Z","steps":["trace[1842360695] 'process raft request' (duration: 959.356226ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:53.509754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:50:52.550013Z","time spent":"959.581002ms","remote":"127.0.0.1:60606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:50:53.509848Z","caller":"traceutil/trace.go:171","msg":"trace[745692718] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"496.931747ms","start":"2026-05-26T15:50:53.012898Z","end":"2026-05-26T15:50:53.50983Z","steps":["trace[745692718] 'process raft request' (duration: 496.584418ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:50:53.509997Z","caller":"traceutil/trace.go:171","msg":"trace[112011971] linearizableReadLoop","detail":"{readStateIndex:1947; appliedIndex:1945; }","duration":"529.32545ms","start":"2026-05-26T15:50:52.980656Z","end":"2026-05-26T15:50:53.509982Z","steps":["trace[112011971] 'read index received' (duration: 421.309925ms)","trace[112011971] 'applied index is now lower than readState.Index' (duration: 108.014765ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:50:53.510067Z","caller":"traceutil/trace.go:171","msg":"trace[254123926] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"204.621976ms","start":"2026-05-26T15:50:53.305436Z","end":"2026-05-26T15:50:53.510058Z","steps":["trace[254123926] 'process raft request' (duration: 204.266607ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:53.510077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:50:53.012869Z","time spent":"497.06684ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T15:50:53.510245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.589259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T15:50:53.510282Z","caller":"traceutil/trace.go:171","msg":"trace[920362980] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1879; }","duration":"529.668072ms","start":"2026-05-26T15:50:52.980604Z","end":"2026-05-26T15:50:53.510272Z","steps":["trace[920362980] 'agreement among raft nodes before linearized reading' (duration: 529.57755ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:53.510311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:50:52.980581Z","time spent":"529.722103ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":67,"response size":29,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"info","ts":"2026-05-26T15:50:53.655886Z","caller":"traceutil/trace.go:171","msg":"trace[1213642044] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"195.583026ms","start":"2026-05-26T15:50:53.460277Z","end":"2026-05-26T15:50:53.65586Z","steps":["trace[1213642044] 'process raft request' (duration: 156.829215ms)","trace[1213642044] 'compare' (duration: 38.553085ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:50:53.65605Z","caller":"traceutil/trace.go:171","msg":"trace[1470404355] linearizableReadLoop","detail":"{readStateIndex:1951; appliedIndex:1949; }","duration":"145.994926ms","start":"2026-05-26T15:50:53.510036Z","end":"2026-05-26T15:50:53.656031Z","steps":["trace[1470404355] 'read index received' (duration: 107.06285ms)","trace[1470404355] 'applied index is now lower than readState.Index' (duration: 38.930526ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:50:53.656192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.365063ms","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-05-26T15:50:53.656219Z","caller":"traceutil/trace.go:171","msg":"trace[295050035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1881; }","duration":"368.424765ms","start":"2026-05-26T15:50:53.287786Z","end":"2026-05-26T15:50:53.656211Z","steps":["trace[295050035] 'agreement among raft nodes before linearized reading' (duration: 368.297302ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:53.656239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:50:53.287774Z","time spent":"368.460246ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-26T15:50:53.656243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.747104ms","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-05-26T15:50:53.656264Z","caller":"traceutil/trace.go:171","msg":"trace[720896459] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1881; }","duration":"372.797545ms","start":"2026-05-26T15:50:53.28346Z","end":"2026-05-26T15:50:53.656257Z","steps":["trace[720896459] 'agreement among raft nodes before linearized reading' (duration: 372.728453ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:53.656256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.334849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-26T15:50:53.656293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:50:53.283443Z","time spent":"372.835966ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-26T15:50:53.656298Z","caller":"traceutil/trace.go:171","msg":"trace[939008712] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1881; }","duration":"577.38367ms","start":"2026-05-26T15:50:53.078902Z","end":"2026-05-26T15:50:53.656286Z","steps":["trace[939008712] 'agreement among raft nodes before linearized reading' (duration: 577.303288ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:50:53.656324Z","caller":"traceutil/trace.go:171","msg":"trace[1723960534] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"192.931093ms","start":"2026-05-26T15:50:53.463387Z","end":"2026-05-26T15:50:53.656318Z","steps":["trace[1723960534] 'process raft request' (duration: 192.408559ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:53.65633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:50:53.078847Z","time spent":"577.475033ms","remote":"127.0.0.1:60912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":12,"response size":29,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-05-26T15:50:53.656389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.731876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"} {"level":"info","ts":"2026-05-26T15:50:53.656427Z","caller":"traceutil/trace.go:171","msg":"trace[1952954699] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1881; }","duration":"142.766766ms","start":"2026-05-26T15:50:53.513634Z","end":"2026-05-26T15:50:53.6564Z","steps":["trace[1952954699] 'agreement among raft nodes before linearized reading' (duration: 142.712415ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:53.656529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.068595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-26T15:50:53.656549Z","caller":"traceutil/trace.go:171","msg":"trace[403772639] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1881; }","duration":"109.104256ms","start":"2026-05-26T15:50:53.547439Z","end":"2026-05-26T15:50:53.656543Z","steps":["trace[403772639] 'agreement among raft nodes before linearized reading' (duration: 109.046554ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:53.656626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.495356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-852edd15-2d48-4f66-9261-2be179381e99\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-05-26T15:50:53.656646Z","caller":"traceutil/trace.go:171","msg":"trace[234548811] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-852edd15-2d48-4f66-9261-2be179381e99; range_end:; response_count:1; response_revision:1881; }","duration":"109.558319ms","start":"2026-05-26T15:50:53.547082Z","end":"2026-05-26T15:50:53.65664Z","steps":["trace[234548811] 'agreement among raft nodes before linearized reading' (duration: 109.496457ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:53.656713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.232001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-26T15:50:53.656732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.41633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:50:53.656749Z","caller":"traceutil/trace.go:171","msg":"trace[835645537] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1881; }","duration":"429.466422ms","start":"2026-05-26T15:50:53.227278Z","end":"2026-05-26T15:50:53.656744Z","steps":["trace[835645537] 'agreement among raft nodes before linearized reading' (duration: 429.441101ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:50:53.656746Z","caller":"traceutil/trace.go:171","msg":"trace[1216643552] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1881; }","duration":"384.312503ms","start":"2026-05-26T15:50:53.272424Z","end":"2026-05-26T15:50:53.656736Z","steps":["trace[1216643552] 'agreement among raft nodes before linearized reading' (duration: 384.218301ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:53.656764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:50:53.227258Z","time spent":"429.501662ms","remote":"127.0.0.1:60406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-26T15:50:53.656774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:50:53.272397Z","time spent":"384.370415ms","remote":"127.0.0.1:60698","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-05-26T15:50:54.313195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.069828ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T15:50:54.313328Z","caller":"traceutil/trace.go:171","msg":"trace[579144868] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"563.61793ms","start":"2026-05-26T15:50:53.7497Z","end":"2026-05-26T15:50:54.313318Z","steps":["trace[579144868] 'process raft request' (duration: 563.593979ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:54.313363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:50:53.749694Z","time spent":"563.652201ms","remote":"127.0.0.1:60700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:50:54.313458Z","caller":"traceutil/trace.go:171","msg":"trace[1786268202] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"564.406541ms","start":"2026-05-26T15:50:53.748963Z","end":"2026-05-26T15:50:54.313369Z","steps":["trace[1786268202] 'process raft request' (duration: 138.101967ms)","trace[1786268202] 'compare' (duration: 425.910764ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:50:54.313661Z","caller":"traceutil/trace.go:171","msg":"trace[1217229806] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"564.405182ms","start":"2026-05-26T15:50:53.749233Z","end":"2026-05-26T15:50:54.313639Z","steps":["trace[1217229806] 'process raft request' (duration: 564.022331ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:54.313764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:50:53.749226Z","time spent":"564.480204ms","remote":"127.0.0.1:60700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T15:50:54.313843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:50:53.74895Z","time spent":"564.711269ms","remote":"127.0.0.1:60588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:50:54.373245Z","caller":"traceutil/trace.go:171","msg":"trace[1597118954] linearizableReadLoop","detail":"{readStateIndex:1960; appliedIndex:1956; }","duration":"499.441099ms","start":"2026-05-26T15:50:53.873787Z","end":"2026-05-26T15:50:54.373228Z","steps":["trace[1597118954] 'read index received' (duration: 13.291667ms)","trace[1597118954] 'applied index is now lower than readState.Index' (duration: 486.148762ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:50:54.373304Z","caller":"traceutil/trace.go:171","msg":"trace[99126755] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"508.393976ms","start":"2026-05-26T15:50:53.864875Z","end":"2026-05-26T15:50:54.373268Z","steps":["trace[99126755] 'process raft request' (duration: 508.241182ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:54.373425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.629813ms","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-05-26T15:50:54.373445Z","caller":"traceutil/trace.go:171","msg":"trace[1115691795] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1890; }","duration":"499.706535ms","start":"2026-05-26T15:50:53.873732Z","end":"2026-05-26T15:50:54.373439Z","steps":["trace[1115691795] 'agreement among raft nodes before linearized reading' (duration: 499.594712ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:54.373466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:50:53.873712Z","time spent":"499.748827ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T15:50:54.373475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:50:53.864824Z","time spent":"508.553591ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:50:59.842076Z","caller":"traceutil/trace.go:171","msg":"trace[2083820490] transaction","detail":"{read_only:false; response_revision:1939; number_of_response:1; }","duration":"315.065746ms","start":"2026-05-26T15:50:59.526983Z","end":"2026-05-26T15:50:59.842049Z","steps":["trace[2083820490] 'process raft request' (duration: 313.45163ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:59.842228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:50:59.526958Z","time spent":"315.194519ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:50:59.845735Z","caller":"traceutil/trace.go:171","msg":"trace[326890457] linearizableReadLoop","detail":"{readStateIndex:2011; appliedIndex:2009; }","duration":"150.350083ms","start":"2026-05-26T15:50:59.69536Z","end":"2026-05-26T15:50:59.84571Z","steps":["trace[326890457] 'read index received' (duration: 145.129848ms)","trace[326890457] 'applied index is now lower than readState.Index' (duration: 5.219095ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:50:59.845836Z","caller":"traceutil/trace.go:171","msg":"trace[1844988085] transaction","detail":"{read_only:false; response_revision:1940; number_of_response:1; }","duration":"169.537536ms","start":"2026-05-26T15:50:59.676264Z","end":"2026-05-26T15:50:59.845802Z","steps":["trace[1844988085] 'process raft request' (duration: 169.32482ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:59.846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.870704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-26T15:50:59.846059Z","caller":"traceutil/trace.go:171","msg":"trace[1376992458] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1940; }","duration":"147.947436ms","start":"2026-05-26T15:50:59.698095Z","end":"2026-05-26T15:50:59.846042Z","steps":["trace[1376992458] 'agreement among raft nodes before linearized reading' (duration: 147.762291ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:50:59.846489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.108224ms","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-05-26T15:50:59.846609Z","caller":"traceutil/trace.go:171","msg":"trace[1797823377] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1940; }","duration":"151.288549ms","start":"2026-05-26T15:50:59.695301Z","end":"2026-05-26T15:50:59.846589Z","steps":["trace[1797823377] 'agreement among raft nodes before linearized reading' (duration: 150.730643ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:06.04324Z","caller":"traceutil/trace.go:171","msg":"trace[1613240709] transaction","detail":"{read_only:false; response_revision:1985; number_of_response:1; }","duration":"165.657726ms","start":"2026-05-26T15:51:05.876871Z","end":"2026-05-26T15:51:06.042529Z","steps":["trace[1613240709] 'process raft request' (duration: 165.45631ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:06.079005Z","caller":"traceutil/trace.go:171","msg":"trace[1697232845] linearizableReadLoop","detail":"{readStateIndex:2058; appliedIndex:2056; }","duration":"192.710264ms","start":"2026-05-26T15:51:05.886279Z","end":"2026-05-26T15:51:06.078989Z","steps":["trace[1697232845] 'read index received' (duration: 156.011697ms)","trace[1697232845] 'applied index is now lower than readState.Index' (duration: 36.697617ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:51:06.079054Z","caller":"traceutil/trace.go:171","msg":"trace[1282146436] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"193.866076ms","start":"2026-05-26T15:51:05.885166Z","end":"2026-05-26T15:51:06.079032Z","steps":["trace[1282146436] 'process raft request' (duration: 193.727442ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:06.079369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.047877ms","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-05-26T15:51:06.079491Z","caller":"traceutil/trace.go:171","msg":"trace[1433622099] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1986; }","duration":"191.214492ms","start":"2026-05-26T15:51:05.888258Z","end":"2026-05-26T15:51:06.079472Z","steps":["trace[1433622099] 'agreement among raft nodes before linearized reading' (duration: 190.977285ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:06.079369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.527973ms","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-05-26T15:51:06.079612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.995186ms","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-05-26T15:51:06.079672Z","caller":"traceutil/trace.go:171","msg":"trace[116600360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1986; }","duration":"190.865312ms","start":"2026-05-26T15:51:05.888791Z","end":"2026-05-26T15:51:06.079657Z","steps":["trace[116600360] 'agreement among raft nodes before linearized reading' (duration: 190.462971ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:06.079599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.307441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-26T15:51:06.079821Z","caller":"traceutil/trace.go:171","msg":"trace[442776737] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1986; }","duration":"193.527817ms","start":"2026-05-26T15:51:05.886274Z","end":"2026-05-26T15:51:06.079802Z","steps":["trace[442776737] 'agreement among raft nodes before linearized reading' (duration: 192.830718ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:06.079799Z","caller":"traceutil/trace.go:171","msg":"trace[423895509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1986; }","duration":"191.12179ms","start":"2026-05-26T15:51:05.888561Z","end":"2026-05-26T15:51:06.079683Z","steps":["trace[423895509] 'agreement among raft nodes before linearized reading' (duration: 190.754449ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:06.877663Z","caller":"traceutil/trace.go:171","msg":"trace[989060188] linearizableReadLoop","detail":"{readStateIndex:2062; appliedIndex:2061; }","duration":"381.157865ms","start":"2026-05-26T15:51:06.496481Z","end":"2026-05-26T15:51:06.877639Z","steps":["trace[989060188] 'read index received' (duration: 381.010361ms)","trace[989060188] 'applied index is now lower than readState.Index' (duration: 145.994µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:51:06.87771Z","caller":"traceutil/trace.go:171","msg":"trace[1431836160] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"472.262476ms","start":"2026-05-26T15:51:06.405418Z","end":"2026-05-26T15:51:06.877681Z","steps":["trace[1431836160] 'process raft request' (duration: 472.059801ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:06.878012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:06.40539Z","time spent":"472.3884ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T15:51:06.878248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.764902ms","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-05-26T15:51:06.878326Z","caller":"traceutil/trace.go:171","msg":"trace[1368612112] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1990; }","duration":"381.888496ms","start":"2026-05-26T15:51:06.496425Z","end":"2026-05-26T15:51:06.878314Z","steps":["trace[1368612112] 'agreement among raft nodes before linearized reading' (duration: 381.527535ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:06.878401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:06.496404Z","time spent":"381.949338ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T15:51:07.377786Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8099053661411615160,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T15:51:07.878046Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8099053661411615160,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T15:51:08.378508Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8099053661411615160,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T15:51:08.416991Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.01773143s","expected-duration":"1s"} {"level":"info","ts":"2026-05-26T15:51:08.417539Z","caller":"traceutil/trace.go:171","msg":"trace[483275272] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"1.604733688s","start":"2026-05-26T15:51:06.81278Z","end":"2026-05-26T15:51:08.417513Z","steps":["trace[483275272] 'process raft request' (duration: 1.604679997s)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:08.417634Z","caller":"traceutil/trace.go:171","msg":"trace[1984952543] transaction","detail":"{read_only:false; response_revision:1991; number_of_response:1; }","duration":"1.808561068s","start":"2026-05-26T15:51:06.609038Z","end":"2026-05-26T15:51:08.417599Z","steps":["trace[1984952543] 'process raft request' (duration: 1.808254599s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:08.417692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:06.812753Z","time spent":"1.604858702s","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T15:51:08.417791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:06.609009Z","time spent":"1.808696332s","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T15:51:08.889395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.473081ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T15:51:08.889641Z","caller":"traceutil/trace.go:171","msg":"trace[451959892] transaction","detail":"{read_only:false; response_revision:1993; number_of_response:1; }","duration":"2.006825403s","start":"2026-05-26T15:51:06.882784Z","end":"2026-05-26T15:51:08.889609Z","steps":["trace[451959892] 'process raft request' (duration: 1.671065564s)","trace[451959892] 'compare' (duration: 335.296886ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:51:08.889841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:06.882767Z","time spent":"2.006951237s","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T15:51:09.228123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000167483s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-26T15:51:09.228205Z","caller":"traceutil/trace.go:171","msg":"trace[503824610] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000308947s","start":"2026-05-26T15:51:07.22788Z","end":"2026-05-26T15:51:09.228189Z","steps":["trace[503824610] 'agreement among raft nodes before linearized reading' (duration: 2.000207904s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:09.228294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:07.227859Z","time spent":"2.000423881s","remote":"127.0.0.1:60406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-26T15:51:09.404876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.37582ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-26T15:51:09.406035Z","caller":"traceutil/trace.go:171","msg":"trace[1920372813] transaction","detail":"{read_only:false; response_revision:1994; number_of_response:1; }","duration":"1.357718443s","start":"2026-05-26T15:51:08.048298Z","end":"2026-05-26T15:51:09.406017Z","steps":["trace[1920372813] 'process raft request' (duration: 1.356755035s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:09.406279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:08.048275Z","time spent":"1.357812335s","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T15:51:09.553009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.912384ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T15:51:09.553205Z","caller":"traceutil/trace.go:171","msg":"trace[1855264179] transaction","detail":"{read_only:false; response_revision:1995; number_of_response:1; }","duration":"1.469610924s","start":"2026-05-26T15:51:08.083569Z","end":"2026-05-26T15:51:09.55318Z","steps":["trace[1855264179] 'process raft request' (duration: 1.322435133s)","trace[1855264179] 'compare' (duration: 146.630856ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:51:09.553335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:08.083555Z","time spent":"1.469711747s","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:51:09.553388Z","caller":"traceutil/trace.go:171","msg":"trace[899863130] linearizableReadLoop","detail":"{readStateIndex:2068; appliedIndex:2062; }","duration":"2.675616779s","start":"2026-05-26T15:51:06.877742Z","end":"2026-05-26T15:51:09.553359Z","steps":["trace[899863130] 'read index received' (duration: 1.539545623s)","trace[899863130] 'applied index is now lower than readState.Index' (duration: 1.136068936s)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:51:09.55361Z","caller":"traceutil/trace.go:171","msg":"trace[320248655] transaction","detail":"{read_only:false; response_revision:1997; number_of_response:1; }","duration":"668.92513ms","start":"2026-05-26T15:51:08.88456Z","end":"2026-05-26T15:51:09.553485Z","steps":["trace[320248655] 'process raft request' (duration: 668.744505ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:09.55372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:08.884531Z","time spent":"669.135637ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T15:51:09.553801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.441355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:51:09.553824Z","caller":"traceutil/trace.go:171","msg":"trace[1200205947] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1997; }","duration":"602.504328ms","start":"2026-05-26T15:51:08.951311Z","end":"2026-05-26T15:51:09.553816Z","steps":["trace[1200205947] 'agreement among raft nodes before linearized reading' (duration: 602.471567ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:09.553818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.465520204s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-05-26T15:51:09.553848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:08.95129Z","time spent":"602.55218ms","remote":"127.0.0.1:51268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-26T15:51:09.553868Z","caller":"traceutil/trace.go:171","msg":"trace[1991532486] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1997; }","duration":"2.465616277s","start":"2026-05-26T15:51:07.088238Z","end":"2026-05-26T15:51:09.553854Z","steps":["trace[1991532486] 'agreement among raft nodes before linearized reading' (duration: 2.465418192s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:09.553872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.448619716s","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-05-26T15:51:09.553926Z","caller":"traceutil/trace.go:171","msg":"trace[2031209931] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1997; }","duration":"1.448686979s","start":"2026-05-26T15:51:08.105225Z","end":"2026-05-26T15:51:09.553912Z","steps":["trace[2031209931] 'agreement among raft nodes before linearized reading' (duration: 1.448570775s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:09.55395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:07.088217Z","time spent":"2.465679658s","remote":"127.0.0.1:59198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-26T15:51:09.553974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:08.105215Z","time spent":"1.44874916s","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-26T15:51:09.554055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.686005242s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:51:09.554129Z","caller":"traceutil/trace.go:171","msg":"trace[1946519873] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:1997; }","duration":"1.686116615s","start":"2026-05-26T15:51:07.868005Z","end":"2026-05-26T15:51:09.554121Z","steps":["trace[1946519873] 'agreement among raft nodes before linearized reading' (duration: 1.686016433s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:09.554153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:07.867986Z","time spent":"1.686158677s","remote":"127.0.0.1:58624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true "} {"level":"warn","ts":"2026-05-26T15:51:09.554231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.895583627s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-26T15:51:09.554293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.454382527s","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-05-26T15:51:09.554289Z","caller":"traceutil/trace.go:171","msg":"trace[1441060816] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1997; }","duration":"1.895691341s","start":"2026-05-26T15:51:07.65858Z","end":"2026-05-26T15:51:09.554271Z","steps":["trace[1441060816] 'agreement among raft nodes before linearized reading' (duration: 1.895562807s)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:09.554314Z","caller":"traceutil/trace.go:171","msg":"trace[878203994] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1997; }","duration":"1.454428488s","start":"2026-05-26T15:51:08.099877Z","end":"2026-05-26T15:51:09.554306Z","steps":["trace[878203994] 'agreement among raft nodes before linearized reading' (duration: 1.454366577s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:09.554338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:08.099865Z","time spent":"1.454469209s","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T15:51:09.554332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:07.658536Z","time spent":"1.895784413s","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T15:51:09.553737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.448879474s","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-05-26T15:51:09.554545Z","caller":"traceutil/trace.go:171","msg":"trace[359664940] transaction","detail":"{read_only:false; response_revision:1996; number_of_response:1; }","duration":"1.03102708s","start":"2026-05-26T15:51:08.523507Z","end":"2026-05-26T15:51:09.554535Z","steps":["trace[359664940] 'process raft request' (duration: 1.02961872s)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:09.554569Z","caller":"traceutil/trace.go:171","msg":"trace[2042249712] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1997; }","duration":"1.449740507s","start":"2026-05-26T15:51:08.104809Z","end":"2026-05-26T15:51:09.55455Z","steps":["trace[2042249712] 'agreement among raft nodes before linearized reading' (duration: 1.448851753s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:09.554617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:08.523476Z","time spent":"1.031088652s","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T15:51:09.554649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:08.104797Z","time spent":"1.449842021s","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-26T15:51:09.553744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.70203441s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-jbxsk\" ","response":"range_response_count:1 size:5855"} {"level":"info","ts":"2026-05-26T15:51:09.554712Z","caller":"traceutil/trace.go:171","msg":"trace[168069155] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-jbxsk; range_end:; response_count:1; response_revision:1997; }","duration":"2.703062719s","start":"2026-05-26T15:51:06.851642Z","end":"2026-05-26T15:51:09.554705Z","steps":["trace[168069155] 'agreement among raft nodes before linearized reading' (duration: 2.701881965s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:09.554733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:06.851621Z","time spent":"2.703105329s","remote":"127.0.0.1:60606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":5877,"request content":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-jbxsk\" "} {"level":"warn","ts":"2026-05-26T15:51:09.55377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.967935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:51:09.554785Z","caller":"traceutil/trace.go:171","msg":"trace[133190134] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1997; }","duration":"326.003763ms","start":"2026-05-26T15:51:09.228768Z","end":"2026-05-26T15:51:09.554772Z","steps":["trace[133190134] 'agreement among raft nodes before linearized reading' (duration: 324.988515ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:09.554819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:09.228752Z","time spent":"326.057684ms","remote":"127.0.0.1:60408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-26T15:51:09.675377Z","caller":"traceutil/trace.go:171","msg":"trace[1451643137] transaction","detail":"{read_only:false; response_revision:1999; number_of_response:1; }","duration":"115.295367ms","start":"2026-05-26T15:51:09.560053Z","end":"2026-05-26T15:51:09.675349Z","steps":["trace[1451643137] 'process raft request' (duration: 111.007657ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:09.675566Z","caller":"traceutil/trace.go:171","msg":"trace[516145340] transaction","detail":"{read_only:false; response_revision:2001; number_of_response:1; }","duration":"114.514146ms","start":"2026-05-26T15:51:09.561033Z","end":"2026-05-26T15:51:09.675547Z","steps":["trace[516145340] 'process raft request' (duration: 114.280299ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:09.67539Z","caller":"traceutil/trace.go:171","msg":"trace[356960591] transaction","detail":"{read_only:false; response_revision:2000; number_of_response:1; }","duration":"114.455634ms","start":"2026-05-26T15:51:09.560906Z","end":"2026-05-26T15:51:09.675362Z","steps":["trace[356960591] 'process raft request' (duration: 114.355241ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:09.675887Z","caller":"traceutil/trace.go:171","msg":"trace[1762480726] transaction","detail":"{read_only:false; response_revision:2002; number_of_response:1; }","duration":"114.649609ms","start":"2026-05-26T15:51:09.561224Z","end":"2026-05-26T15:51:09.675873Z","steps":["trace[1762480726] 'process raft request' (duration: 114.34644ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:09.676036Z","caller":"traceutil/trace.go:171","msg":"trace[184979032] transaction","detail":"{read_only:false; response_revision:2003; number_of_response:1; }","duration":"112.584821ms","start":"2026-05-26T15:51:09.56344Z","end":"2026-05-26T15:51:09.676025Z","steps":["trace[184979032] 'process raft request' (duration: 112.381575ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:09.676051Z","caller":"traceutil/trace.go:171","msg":"trace[1296030060] linearizableReadLoop","detail":"{readStateIndex:2075; appliedIndex:2071; }","duration":"112.706164ms","start":"2026-05-26T15:51:09.563328Z","end":"2026-05-26T15:51:09.676034Z","steps":["trace[1296030060] 'read index received' (duration: 58.583295ms)","trace[1296030060] 'applied index is now lower than readState.Index' (duration: 54.121139ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:51:09.676247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.822597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:51:09.676493Z","caller":"traceutil/trace.go:171","msg":"trace[434768693] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2003; }","duration":"113.148277ms","start":"2026-05-26T15:51:09.563306Z","end":"2026-05-26T15:51:09.676454Z","steps":["trace[434768693] 'agreement among raft nodes before linearized reading' (duration: 112.811308ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:09.909476Z","caller":"traceutil/trace.go:171","msg":"trace[1843858398] transaction","detail":"{read_only:false; response_revision:2009; number_of_response:1; }","duration":"151.438464ms","start":"2026-05-26T15:51:09.758018Z","end":"2026-05-26T15:51:09.909456Z","steps":["trace[1843858398] 'process raft request' (duration: 151.284258ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:09.910062Z","caller":"traceutil/trace.go:171","msg":"trace[1909650703] transaction","detail":"{read_only:false; response_revision:2010; number_of_response:1; }","duration":"150.113486ms","start":"2026-05-26T15:51:09.759924Z","end":"2026-05-26T15:51:09.910037Z","steps":["trace[1909650703] 'process raft request' (duration: 149.480228ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:09.910096Z","caller":"traceutil/trace.go:171","msg":"trace[869853733] transaction","detail":"{read_only:false; response_revision:2011; number_of_response:1; }","duration":"149.928241ms","start":"2026-05-26T15:51:09.760154Z","end":"2026-05-26T15:51:09.910082Z","steps":["trace[869853733] 'process raft request' (duration: 149.615502ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:10.063912Z","caller":"traceutil/trace.go:171","msg":"trace[618556934] transaction","detail":"{read_only:false; response_revision:2012; number_of_response:1; }","duration":"144.645883ms","start":"2026-05-26T15:51:09.919173Z","end":"2026-05-26T15:51:10.063819Z","steps":["trace[618556934] 'process raft request' (duration: 55.157359ms)","trace[618556934] 'compare' (duration: 89.154245ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:51:12.107368Z","caller":"traceutil/trace.go:171","msg":"trace[1004244519] transaction","detail":"{read_only:false; response_revision:2025; number_of_response:1; }","duration":"119.431152ms","start":"2026-05-26T15:51:11.987912Z","end":"2026-05-26T15:51:12.107343Z","steps":["trace[1004244519] 'process raft request' (duration: 119.269978ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:12.107457Z","caller":"traceutil/trace.go:171","msg":"trace[881033384] linearizableReadLoop","detail":"{readStateIndex:2098; appliedIndex:2097; }","duration":"115.546273ms","start":"2026-05-26T15:51:11.991885Z","end":"2026-05-26T15:51:12.107431Z","steps":["trace[881033384] 'read index received' (duration: 115.262995ms)","trace[881033384] 'applied index is now lower than readState.Index' (duration: 281.008µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:51:12.107678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.7935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.153\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-26T15:51:12.107724Z","caller":"traceutil/trace.go:171","msg":"trace[1320708146] range","detail":"{range_begin:/registry/masterleases/199.19.213.153; range_end:; response_count:1; response_revision:2025; }","duration":"115.902552ms","start":"2026-05-26T15:51:11.991809Z","end":"2026-05-26T15:51:12.107711Z","steps":["trace[1320708146] 'agreement among raft nodes before linearized reading' (duration: 115.708267ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:12.913499Z","caller":"traceutil/trace.go:171","msg":"trace[76171153] linearizableReadLoop","detail":"{readStateIndex:2101; appliedIndex:2100; }","duration":"337.271605ms","start":"2026-05-26T15:51:12.576206Z","end":"2026-05-26T15:51:12.913478Z","steps":["trace[76171153] 'read index received' (duration: 337.06802ms)","trace[76171153] 'applied index is now lower than readState.Index' (duration: 200.325µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:51:12.913553Z","caller":"traceutil/trace.go:171","msg":"trace[434791154] transaction","detail":"{read_only:false; response_revision:2027; number_of_response:1; }","duration":"480.782485ms","start":"2026-05-26T15:51:12.432749Z","end":"2026-05-26T15:51:12.913531Z","steps":["trace[434791154] 'process raft request' (duration: 480.581019ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:12.913681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:12.432722Z","time spent":"480.876318ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T15:51:12.913718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.510372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-26T15:51:12.913767Z","caller":"traceutil/trace.go:171","msg":"trace[1248947358] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2027; }","duration":"337.599734ms","start":"2026-05-26T15:51:12.576152Z","end":"2026-05-26T15:51:12.913752Z","steps":["trace[1248947358] 'agreement among raft nodes before linearized reading' (duration: 337.45525ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:12.9138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:12.576124Z","time spent":"337.668776ms","remote":"127.0.0.1:59198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-05-26T15:51:13.17799Z","caller":"traceutil/trace.go:171","msg":"trace[1860372251] linearizableReadLoop","detail":"{readStateIndex:2102; appliedIndex:2101; }","duration":"213.949706ms","start":"2026-05-26T15:51:12.964015Z","end":"2026-05-26T15:51:13.177965Z","steps":["trace[1860372251] 'read index received' (duration: 212.608129ms)","trace[1860372251] 'applied index is now lower than readState.Index' (duration: 1.340667ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:51:13.178162Z","caller":"traceutil/trace.go:171","msg":"trace[1916863532] transaction","detail":"{read_only:false; response_revision:2028; number_of_response:1; }","duration":"260.192749ms","start":"2026-05-26T15:51:12.917935Z","end":"2026-05-26T15:51:13.178128Z","steps":["trace[1916863532] 'process raft request' (duration: 258.707948ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:13.17824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.128891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:51:13.178295Z","caller":"traceutil/trace.go:171","msg":"trace[1294300628] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:2028; }","duration":"214.303696ms","start":"2026-05-26T15:51:12.963974Z","end":"2026-05-26T15:51:13.178278Z","steps":["trace[1294300628] 'agreement among raft nodes before linearized reading' (duration: 214.09688ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:31.112455Z","caller":"traceutil/trace.go:171","msg":"trace[911651314] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"131.788669ms","start":"2026-05-26T15:51:30.98062Z","end":"2026-05-26T15:51:31.112409Z","steps":["trace[911651314] 'process raft request' (duration: 131.157101ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:31.640481Z","caller":"traceutil/trace.go:171","msg":"trace[2117196715] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"142.893686ms","start":"2026-05-26T15:51:31.497565Z","end":"2026-05-26T15:51:31.640459Z","steps":["trace[2117196715] 'process raft request' (duration: 142.770582ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:31.886859Z","caller":"traceutil/trace.go:171","msg":"trace[1302425643] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"102.689259ms","start":"2026-05-26T15:51:31.784149Z","end":"2026-05-26T15:51:31.886838Z","steps":["trace[1302425643] 'process raft request' (duration: 57.906512ms)","trace[1302425643] 'compare' (duration: 44.661274ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:51:32.518967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.849029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.153\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-05-26T15:51:32.518964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.995395ms","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-05-26T15:51:32.519053Z","caller":"traceutil/trace.go:171","msg":"trace[190112987] range","detail":"{range_begin:/registry/masterleases/199.19.213.153; range_end:; response_count:1; response_revision:2138; }","duration":"525.972962ms","start":"2026-05-26T15:51:31.993054Z","end":"2026-05-26T15:51:32.519027Z","steps":["trace[190112987] 'range keys from in-memory index tree' (duration: 525.643243ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:32.519088Z","caller":"traceutil/trace.go:171","msg":"trace[1740559680] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2138; }","duration":"140.137049ms","start":"2026-05-26T15:51:32.378932Z","end":"2026-05-26T15:51:32.519069Z","steps":["trace[1740559680] 'range keys from in-memory index tree' (duration: 139.980595ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:32.519099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:31.993035Z","time spent":"526.049894ms","remote":"127.0.0.1:60470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.153\" "} {"level":"warn","ts":"2026-05-26T15:51:32.519093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.991606ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T15:51:32.519468Z","caller":"traceutil/trace.go:171","msg":"trace[934248403] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"443.295424ms","start":"2026-05-26T15:51:32.07615Z","end":"2026-05-26T15:51:32.519446Z","steps":["trace[934248403] 'process raft request' (duration: 117.881455ms)","trace[934248403] 'compare' (duration: 324.824341ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:51:32.519575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:32.07612Z","time spent":"443.390676ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:51:32.519179Z","caller":"traceutil/trace.go:171","msg":"trace[895541742] linearizableReadLoop","detail":"{readStateIndex:2216; appliedIndex:2215; }","duration":"400.333746ms","start":"2026-05-26T15:51:32.11883Z","end":"2026-05-26T15:51:32.519164Z","steps":["trace[895541742] 'read index received' (duration: 75.297709ms)","trace[895541742] 'applied index is now lower than readState.Index' (duration: 325.035037ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:51:32.519829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.995846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-05-26T15:51:32.51988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.349506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:51:32.519881Z","caller":"traceutil/trace.go:171","msg":"trace[1291684449] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2139; }","duration":"401.080769ms","start":"2026-05-26T15:51:32.118787Z","end":"2026-05-26T15:51:32.519868Z","steps":["trace[1291684449] 'agreement among raft nodes before linearized reading' (duration: 400.939945ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:32.519894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.157366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:51:32.519919Z","caller":"traceutil/trace.go:171","msg":"trace[1357401891] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:2139; }","duration":"298.451309ms","start":"2026-05-26T15:51:32.221456Z","end":"2026-05-26T15:51:32.519907Z","steps":["trace[1357401891] 'agreement among raft nodes before linearized reading' (duration: 298.350686ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:32.519927Z","caller":"traceutil/trace.go:171","msg":"trace[1189004846] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2139; }","duration":"294.239038ms","start":"2026-05-26T15:51:32.22568Z","end":"2026-05-26T15:51:32.519919Z","steps":["trace[1189004846] 'agreement among raft nodes before linearized reading' (duration: 294.169476ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:32.519924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:32.118728Z","time spent":"401.187892ms","remote":"127.0.0.1:59198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-26T15:51:33.072009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.884885ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T15:51:33.072135Z","caller":"traceutil/trace.go:171","msg":"trace[142996555] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"506.22164ms","start":"2026-05-26T15:51:32.565899Z","end":"2026-05-26T15:51:33.072121Z","steps":["trace[142996555] 'process raft request' (duration: 174.161851ms)","trace[142996555] 'compare' (duration: 331.564405ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:51:33.072183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:32.56588Z","time spent":"506.277402ms","remote":"127.0.0.1:60470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:51:33.472138Z","caller":"traceutil/trace.go:171","msg":"trace[307228819] linearizableReadLoop","detail":"{readStateIndex:2219; appliedIndex:2218; }","duration":"352.490907ms","start":"2026-05-26T15:51:33.119615Z","end":"2026-05-26T15:51:33.472106Z","steps":["trace[307228819] 'read index received' (duration: 352.352253ms)","trace[307228819] 'applied index is now lower than readState.Index' (duration: 138.124µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:51:33.472237Z","caller":"traceutil/trace.go:171","msg":"trace[1356634811] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"354.191056ms","start":"2026-05-26T15:51:33.118026Z","end":"2026-05-26T15:51:33.472217Z","steps":["trace[1356634811] 'process raft request' (duration: 353.94876ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:33.472381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:33.118Z","time spent":"354.290119ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T15:51:33.472468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.73292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:51:33.472522Z","caller":"traceutil/trace.go:171","msg":"trace[364459731] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2141; }","duration":"244.828813ms","start":"2026-05-26T15:51:33.227685Z","end":"2026-05-26T15:51:33.472514Z","steps":["trace[364459731] 'agreement among raft nodes before linearized reading' (duration: 244.599806ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:33.47295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.227478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T15:51:33.472842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.395308ms","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-05-26T15:51:33.473133Z","caller":"traceutil/trace.go:171","msg":"trace[1229616171] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2141; }","duration":"183.737298ms","start":"2026-05-26T15:51:33.289375Z","end":"2026-05-26T15:51:33.473113Z","steps":["trace[1229616171] 'agreement among raft nodes before linearized reading' (duration: 183.092679ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:51:33.473442Z","caller":"traceutil/trace.go:171","msg":"trace[404926955] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:2141; }","duration":"353.412673ms","start":"2026-05-26T15:51:33.119609Z","end":"2026-05-26T15:51:33.473022Z","steps":["trace[404926955] 'agreement among raft nodes before linearized reading' (duration: 352.645181ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:51:33.473627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:51:33.119565Z","time spent":"353.938519ms","remote":"127.0.0.1:59904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-05-26T15:53:34.86524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.760894ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T15:53:34.86545Z","caller":"traceutil/trace.go:171","msg":"trace[1533758759] transaction","detail":"{read_only:false; response_revision:2898; number_of_response:1; }","duration":"375.470837ms","start":"2026-05-26T15:53:34.489947Z","end":"2026-05-26T15:53:34.865418Z","steps":["trace[1533758759] 'process raft request' (duration: 194.462756ms)","trace[1533758759] 'compare' (duration: 180.689462ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:53:34.86562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:53:34.489928Z","time spent":"375.615182ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:53:34.865917Z","caller":"traceutil/trace.go:171","msg":"trace[1304566261] transaction","detail":"{read_only:false; response_revision:2899; number_of_response:1; }","duration":"352.13682ms","start":"2026-05-26T15:53:34.513734Z","end":"2026-05-26T15:53:34.86587Z","steps":["trace[1304566261] 'process raft request' (duration: 351.653266ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:53:34.866035Z","caller":"traceutil/trace.go:171","msg":"trace[1134731494] linearizableReadLoop","detail":"{readStateIndex:3004; appliedIndex:3003; }","duration":"357.574381ms","start":"2026-05-26T15:53:34.508448Z","end":"2026-05-26T15:53:34.866022Z","steps":["trace[1134731494] 'read index received' (duration: 175.997583ms)","trace[1134731494] 'applied index is now lower than readState.Index' (duration: 181.575628ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:53:34.866246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.862056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-26T15:53:34.866306Z","caller":"traceutil/trace.go:171","msg":"trace[677939415] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2899; }","duration":"379.989921ms","start":"2026-05-26T15:53:34.486303Z","end":"2026-05-26T15:53:34.866293Z","steps":["trace[677939415] 'agreement among raft nodes before linearized reading' (duration: 379.810365ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:53:34.866344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:53:34.486272Z","time spent":"380.063403ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T15:53:34.86629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:53:34.513716Z","time spent":"352.263883ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T15:53:34.86651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.980495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T15:53:34.866657Z","caller":"traceutil/trace.go:171","msg":"trace[31718774] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:2899; }","duration":"317.207422ms","start":"2026-05-26T15:53:34.54943Z","end":"2026-05-26T15:53:34.866637Z","steps":["trace[31718774] 'agreement among raft nodes before linearized reading' (duration: 316.7999ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:53:34.866735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:53:34.54941Z","time spent":"317.309534ms","remote":"127.0.0.1:60606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":24,"response size":29,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"info","ts":"2026-05-26T15:53:40.266855Z","caller":"traceutil/trace.go:171","msg":"trace[1649752092] transaction","detail":"{read_only:false; response_revision:2925; number_of_response:1; }","duration":"120.734237ms","start":"2026-05-26T15:53:40.146104Z","end":"2026-05-26T15:53:40.266838Z","steps":["trace[1649752092] 'process raft request' (duration: 120.612973ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:54:31.479108Z","caller":"traceutil/trace.go:171","msg":"trace[425050090] linearizableReadLoop","detail":"{readStateIndex:3310; appliedIndex:3309; }","duration":"340.141872ms","start":"2026-05-26T15:54:31.138937Z","end":"2026-05-26T15:54:31.479079Z","steps":["trace[425050090] 'read index received' (duration: 339.079767ms)","trace[425050090] 'applied index is now lower than readState.Index' (duration: 1.060755ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:54:31.479248Z","caller":"traceutil/trace.go:171","msg":"trace[218859221] transaction","detail":"{read_only:false; response_revision:3192; number_of_response:1; }","duration":"694.262285ms","start":"2026-05-26T15:54:30.78495Z","end":"2026-05-26T15:54:31.479212Z","steps":["trace[218859221] 'process raft request' (duration: 693.19238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:54:31.47945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.494857ms","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-05-26T15:54:31.479494Z","caller":"traceutil/trace.go:171","msg":"trace[1007909648] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3192; }","duration":"340.594059ms","start":"2026-05-26T15:54:31.138887Z","end":"2026-05-26T15:54:31.479481Z","steps":["trace[1007909648] 'agreement among raft nodes before linearized reading' (duration: 340.420067ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:54:31.47948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:54:30.784924Z","time spent":"694.422767ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T15:54:31.47953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:54:31.138867Z","time spent":"340.65454ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-26T15:54:31.481009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.111455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-05-26T15:54:31.481085Z","caller":"traceutil/trace.go:171","msg":"trace[1319153629] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:3192; }","duration":"325.196046ms","start":"2026-05-26T15:54:31.155859Z","end":"2026-05-26T15:54:31.481055Z","steps":["trace[1319153629] 'agreement among raft nodes before linearized reading' (duration: 323.652583ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:54:31.481129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:54:31.155848Z","time spent":"325.270138ms","remote":"127.0.0.1:60618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1391,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"warn","ts":"2026-05-26T15:54:31.481156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.48423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:54:31.481839Z","caller":"traceutil/trace.go:171","msg":"trace[1952125117] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3192; }","duration":"255.236542ms","start":"2026-05-26T15:54:31.226586Z","end":"2026-05-26T15:54:31.481822Z","steps":["trace[1952125117] 'agreement among raft nodes before linearized reading' (duration: 252.813125ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:54:31.481523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.533358ms","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-05-26T15:54:31.481637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.575433ms","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-05-26T15:54:31.48208Z","caller":"traceutil/trace.go:171","msg":"trace[1074671413] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3192; }","duration":"343.058556ms","start":"2026-05-26T15:54:31.138935Z","end":"2026-05-26T15:54:31.481994Z","steps":["trace[1074671413] 'agreement among raft nodes before linearized reading' (duration: 340.430377ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:54:31.482126Z","caller":"traceutil/trace.go:171","msg":"trace[2049967234] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3192; }","duration":"338.092101ms","start":"2026-05-26T15:54:31.144025Z","end":"2026-05-26T15:54:31.482117Z","steps":["trace[2049967234] 'agreement among raft nodes before linearized reading' (duration: 335.505872ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:54:31.482153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:54:31.138916Z","time spent":"343.214618ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-26T15:54:31.482257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:54:31.143973Z","time spent":"338.173892ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T15:54:31.481641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.069616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T15:54:31.482395Z","caller":"traceutil/trace.go:171","msg":"trace[1458965410] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:3192; }","duration":"274.876518ms","start":"2026-05-26T15:54:31.207502Z","end":"2026-05-26T15:54:31.482379Z","steps":["trace[1458965410] 'agreement among raft nodes before linearized reading' (duration: 271.908223ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:56:48.484988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.206169ms","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-05-26T15:56:48.485097Z","caller":"traceutil/trace.go:171","msg":"trace[223010461] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4081; }","duration":"365.369053ms","start":"2026-05-26T15:56:48.119709Z","end":"2026-05-26T15:56:48.485079Z","steps":["trace[223010461] 'range keys from in-memory index tree' (duration: 365.012274ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:56:48.485151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:56:48.119689Z","time spent":"365.452104ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T15:56:48.485211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.431954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-26T15:56:48.485299Z","caller":"traceutil/trace.go:171","msg":"trace[275586072] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4081; }","duration":"365.563286ms","start":"2026-05-26T15:56:48.119717Z","end":"2026-05-26T15:56:48.48528Z","steps":["trace[275586072] 'range keys from in-memory index tree' (duration: 365.25069ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:56:48.485321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.187274ms","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-05-26T15:56:48.485346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:56:48.119704Z","time spent":"365.633088ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-26T15:56:48.485372Z","caller":"traceutil/trace.go:171","msg":"trace[1589068621] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4081; }","duration":"370.283446ms","start":"2026-05-26T15:56:48.115077Z","end":"2026-05-26T15:56:48.485361Z","steps":["trace[1589068621] 'range keys from in-memory index tree' (duration: 370.02997ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:56:48.485362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.688622ms","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-05-26T15:56:48.485448Z","caller":"traceutil/trace.go:171","msg":"trace[1520751554] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4081; }","duration":"372.805715ms","start":"2026-05-26T15:56:48.112624Z","end":"2026-05-26T15:56:48.48543Z","steps":["trace[1520751554] 'range keys from in-memory index tree' (duration: 372.515509ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:56:48.4855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:56:48.112605Z","time spent":"372.885477ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-26T15:56:48.485402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:56:48.115057Z","time spent":"370.339978ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-26T15:57:05.11699Z","caller":"traceutil/trace.go:171","msg":"trace[811321621] transaction","detail":"{read_only:false; response_revision:4612; number_of_response:1; }","duration":"104.174172ms","start":"2026-05-26T15:57:05.012797Z","end":"2026-05-26T15:57:05.116971Z","steps":["trace[811321621] 'process raft request' (duration: 100.456385ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:05.134321Z","caller":"traceutil/trace.go:171","msg":"trace[1843554914] transaction","detail":"{read_only:false; response_revision:4613; number_of_response:1; }","duration":"114.898098ms","start":"2026-05-26T15:57:05.019408Z","end":"2026-05-26T15:57:05.134306Z","steps":["trace[1843554914] 'process raft request' (duration: 114.650012ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:10.406251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.883899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206973"} {"level":"info","ts":"2026-05-26T15:57:10.406356Z","caller":"traceutil/trace.go:171","msg":"trace[10474800] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4748; }","duration":"150.047503ms","start":"2026-05-26T15:57:10.256285Z","end":"2026-05-26T15:57:10.406333Z","steps":["trace[10474800] 'range keys from in-memory index tree' (duration: 148.408315ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:10.406836Z","caller":"traceutil/trace.go:171","msg":"trace[473166858] transaction","detail":"{read_only:false; response_revision:4749; number_of_response:1; }","duration":"148.721071ms","start":"2026-05-26T15:57:10.258088Z","end":"2026-05-26T15:57:10.406809Z","steps":["trace[473166858] 'process raft request' (duration: 148.547307ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:10.590991Z","caller":"traceutil/trace.go:171","msg":"trace[749122450] linearizableReadLoop","detail":"{readStateIndex:4930; appliedIndex:4929; }","duration":"117.574058ms","start":"2026-05-26T15:57:10.47339Z","end":"2026-05-26T15:57:10.590964Z","steps":["trace[749122450] 'read index received' (duration: 37.146586ms)","trace[749122450] 'applied index is now lower than readState.Index' (duration: 80.426702ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:57:10.591158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.754352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-05-26T15:57:10.591138Z","caller":"traceutil/trace.go:171","msg":"trace[1794531706] transaction","detail":"{read_only:false; response_revision:4752; number_of_response:1; }","duration":"123.826527ms","start":"2026-05-26T15:57:10.46727Z","end":"2026-05-26T15:57:10.591097Z","steps":["trace[1794531706] 'process raft request' (duration: 43.346234ms)","trace[1794531706] 'compare' (duration: 80.266748ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:57:10.59124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.845808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-05-26T15:57:10.591257Z","caller":"traceutil/trace.go:171","msg":"trace[300276783] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4752; }","duration":"105.879818ms","start":"2026-05-26T15:57:10.485373Z","end":"2026-05-26T15:57:10.591253Z","steps":["trace[300276783] 'agreement among raft nodes before linearized reading' (duration: 105.828747ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:10.591185Z","caller":"traceutil/trace.go:171","msg":"trace[21119880] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4752; }","duration":"117.815474ms","start":"2026-05-26T15:57:10.47336Z","end":"2026-05-26T15:57:10.591175Z","steps":["trace[21119880] 'agreement among raft nodes before linearized reading' (duration: 117.703011ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:16.782745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.638484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-05-26T15:57:16.782856Z","caller":"traceutil/trace.go:171","msg":"trace[1201964045] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4869; }","duration":"185.768237ms","start":"2026-05-26T15:57:16.597063Z","end":"2026-05-26T15:57:16.782831Z","steps":["trace[1201964045] 'range keys from in-memory index tree' (duration: 185.49175ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:16.917186Z","caller":"traceutil/trace.go:171","msg":"trace[890399620] linearizableReadLoop","detail":"{readStateIndex:5049; appliedIndex:5048; }","duration":"239.649532ms","start":"2026-05-26T15:57:16.677514Z","end":"2026-05-26T15:57:16.917164Z","steps":["trace[890399620] 'read index received' (duration: 239.493458ms)","trace[890399620] 'applied index is now lower than readState.Index' (duration: 152.624µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:57:16.917251Z","caller":"traceutil/trace.go:171","msg":"trace[1897677604] transaction","detail":"{read_only:false; response_revision:4870; number_of_response:1; }","duration":"283.811875ms","start":"2026-05-26T15:57:16.633412Z","end":"2026-05-26T15:57:16.917224Z","steps":["trace[1897677604] 'process raft request' (duration: 283.60884ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:16.917409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.874947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-26T15:57:16.917468Z","caller":"traceutil/trace.go:171","msg":"trace[1926222748] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4870; }","duration":"239.9527ms","start":"2026-05-26T15:57:16.677498Z","end":"2026-05-26T15:57:16.917451Z","steps":["trace[1926222748] 'agreement among raft nodes before linearized reading' (duration: 239.771985ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:16.926648Z","caller":"traceutil/trace.go:171","msg":"trace[532566606] transaction","detail":"{read_only:false; response_revision:4871; number_of_response:1; }","duration":"150.036178ms","start":"2026-05-26T15:57:16.776591Z","end":"2026-05-26T15:57:16.926628Z","steps":["trace[532566606] 'process raft request' (duration: 149.633489ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:16.926859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.258534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-05-26T15:57:16.926924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.196465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-26T15:57:16.927012Z","caller":"traceutil/trace.go:171","msg":"trace[905717526] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4871; }","duration":"235.319728ms","start":"2026-05-26T15:57:16.691674Z","end":"2026-05-26T15:57:16.926994Z","steps":["trace[905717526] 'agreement among raft nodes before linearized reading' (duration: 234.765645ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:16.926951Z","caller":"traceutil/trace.go:171","msg":"trace[1405583960] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4871; }","duration":"222.395998ms","start":"2026-05-26T15:57:16.704544Z","end":"2026-05-26T15:57:16.92694Z","steps":["trace[1405583960] 'agreement among raft nodes before linearized reading' (duration: 222.007558ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:16.926864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.233778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-05-26T15:57:16.927637Z","caller":"traceutil/trace.go:171","msg":"trace[1105981105] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4871; }","duration":"140.045728ms","start":"2026-05-26T15:57:16.787578Z","end":"2026-05-26T15:57:16.927624Z","steps":["trace[1105981105] 'agreement among raft nodes before linearized reading' (duration: 138.927041ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:16.92723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.597949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-26T15:57:16.928006Z","caller":"traceutil/trace.go:171","msg":"trace[630128411] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4871; }","duration":"232.383088ms","start":"2026-05-26T15:57:16.695606Z","end":"2026-05-26T15:57:16.927989Z","steps":["trace[630128411] 'agreement among raft nodes before linearized reading' (duration: 231.058507ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:17.083074Z","caller":"traceutil/trace.go:171","msg":"trace[691419278] transaction","detail":"{read_only:false; response_revision:4873; number_of_response:1; }","duration":"147.968931ms","start":"2026-05-26T15:57:16.935066Z","end":"2026-05-26T15:57:17.083035Z","steps":["trace[691419278] 'process raft request' (duration: 147.741565ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:17.11053Z","caller":"traceutil/trace.go:171","msg":"trace[1095406865] transaction","detail":"{read_only:false; response_revision:4874; number_of_response:1; }","duration":"175.262416ms","start":"2026-05-26T15:57:16.935244Z","end":"2026-05-26T15:57:17.110507Z","steps":["trace[1095406865] 'process raft request' (duration: 175.115133ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:17.110883Z","caller":"traceutil/trace.go:171","msg":"trace[237389866] transaction","detail":"{read_only:false; response_revision:4875; number_of_response:1; }","duration":"175.597406ms","start":"2026-05-26T15:57:16.935276Z","end":"2026-05-26T15:57:17.110873Z","steps":["trace[237389866] 'process raft request' (duration: 175.194995ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:17.110928Z","caller":"traceutil/trace.go:171","msg":"trace[598256681] linearizableReadLoop","detail":"{readStateIndex:5055; appliedIndex:5051; }","duration":"174.019298ms","start":"2026-05-26T15:57:16.93689Z","end":"2026-05-26T15:57:17.11091Z","steps":["trace[598256681] 'read index received' (duration: 145.905591ms)","trace[598256681] 'applied index is now lower than readState.Index' (duration: 28.113167ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:57:17.110949Z","caller":"traceutil/trace.go:171","msg":"trace[286088009] transaction","detail":"{read_only:false; response_revision:4876; number_of_response:1; }","duration":"175.573695ms","start":"2026-05-26T15:57:16.935329Z","end":"2026-05-26T15:57:17.110903Z","steps":["trace[286088009] 'process raft request' (duration: 175.439522ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:17.111263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.364137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-93cb6747-1db1-4f69-b567-6df3b1910b2f\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-26T15:57:17.11129Z","caller":"traceutil/trace.go:171","msg":"trace[355445314] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-93cb6747-1db1-4f69-b567-6df3b1910b2f; range_end:; response_count:1; response_revision:4878; }","duration":"174.428108ms","start":"2026-05-26T15:57:16.936855Z","end":"2026-05-26T15:57:17.111283Z","steps":["trace[355445314] 'agreement among raft nodes before linearized reading' (duration: 174.321875ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:17.111909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.031155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-26T15:57:17.111975Z","caller":"traceutil/trace.go:171","msg":"trace[85887637] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4878; }","duration":"119.177849ms","start":"2026-05-26T15:57:16.99278Z","end":"2026-05-26T15:57:17.111958Z","steps":["trace[85887637] 'agreement among raft nodes before linearized reading' (duration: 119.001655ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:17.113469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.976446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-05-26T15:57:17.113601Z","caller":"traceutil/trace.go:171","msg":"trace[1056644899] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4878; }","duration":"174.137101ms","start":"2026-05-26T15:57:16.939446Z","end":"2026-05-26T15:57:17.113583Z","steps":["trace[1056644899] 'agreement among raft nodes before linearized reading' (duration: 171.793765ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:17.423032Z","caller":"traceutil/trace.go:171","msg":"trace[671613142] transaction","detail":"{read_only:false; response_revision:4887; number_of_response:1; }","duration":"225.255552ms","start":"2026-05-26T15:57:17.197705Z","end":"2026-05-26T15:57:17.422961Z","steps":["trace[671613142] 'process raft request' (duration: 136.227669ms)","trace[671613142] 'compare' (duration: 88.738227ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:57:17.423352Z","caller":"traceutil/trace.go:171","msg":"trace[74810612] transaction","detail":"{read_only:false; response_revision:4888; number_of_response:1; }","duration":"209.856592ms","start":"2026-05-26T15:57:17.213436Z","end":"2026-05-26T15:57:17.423292Z","steps":["trace[74810612] 'process raft request' (duration: 209.379731ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:17.423413Z","caller":"traceutil/trace.go:171","msg":"trace[2070440718] linearizableReadLoop","detail":"{readStateIndex:5066; appliedIndex:5061; }","duration":"223.775437ms","start":"2026-05-26T15:57:17.199596Z","end":"2026-05-26T15:57:17.423371Z","steps":["trace[2070440718] 'read index received' (duration: 34.85896ms)","trace[2070440718] 'applied index is now lower than readState.Index' (duration: 188.912847ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:57:17.560778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.836038ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-26T15:57:17.560949Z","caller":"traceutil/trace.go:171","msg":"trace[1984727539] linearizableReadLoop","detail":"{readStateIndex:5068; appliedIndex:5067; }","duration":"137.327255ms","start":"2026-05-26T15:57:17.423601Z","end":"2026-05-26T15:57:17.560928Z","steps":["trace[1984727539] 'read index received' (duration: 94.012µs)","trace[1984727539] 'applied index is now lower than readState.Index' (duration: 137.231703ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:57:17.561102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.246081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-36d05e8c-3391-4491-8de7-1dc0b69d3c6f\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-05-26T15:57:17.56121Z","caller":"traceutil/trace.go:171","msg":"trace[1280240305] range","detail":"{range_begin:/registry/persistentvolumes/pvc-36d05e8c-3391-4491-8de7-1dc0b69d3c6f; range_end:; response_count:1; response_revision:4888; }","duration":"411.385383ms","start":"2026-05-26T15:57:17.149797Z","end":"2026-05-26T15:57:17.561182Z","steps":["trace[1280240305] 'agreement among raft nodes before linearized reading' (duration: 273.72604ms)","trace[1280240305] 'range keys from in-memory index tree' (duration: 137.410258ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:57:17.561266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:57:17.149787Z","time spent":"411.468715ms","remote":"127.0.0.1:60570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1472,"request content":"key:\"/registry/persistentvolumes/pvc-36d05e8c-3391-4491-8de7-1dc0b69d3c6f\" "} {"level":"warn","ts":"2026-05-26T15:57:17.561365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.306591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-05-26T15:57:17.561468Z","caller":"traceutil/trace.go:171","msg":"trace[818377013] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4888; }","duration":"298.446794ms","start":"2026-05-26T15:57:17.262995Z","end":"2026-05-26T15:57:17.561442Z","steps":["trace[818377013] 'agreement among raft nodes before linearized reading' (duration: 298.025304ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:17.685672Z","caller":"traceutil/trace.go:171","msg":"trace[1332793500] transaction","detail":"{read_only:false; response_revision:4891; number_of_response:1; }","duration":"116.081065ms","start":"2026-05-26T15:57:17.569568Z","end":"2026-05-26T15:57:17.685649Z","steps":["trace[1332793500] 'process raft request' (duration: 113.37941ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:17.686087Z","caller":"traceutil/trace.go:171","msg":"trace[542964839] transaction","detail":"{read_only:false; response_revision:4892; number_of_response:1; }","duration":"110.587383ms","start":"2026-05-26T15:57:17.575462Z","end":"2026-05-26T15:57:17.686049Z","steps":["trace[542964839] 'process raft request' (duration: 110.139622ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:17.686194Z","caller":"traceutil/trace.go:171","msg":"trace[1435611497] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"109.652169ms","start":"2026-05-26T15:57:17.576531Z","end":"2026-05-26T15:57:17.686183Z","steps":["trace[1435611497] 'process raft request' (duration: 109.574807ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:17.686225Z","caller":"traceutil/trace.go:171","msg":"trace[1426692576] linearizableReadLoop","detail":"{readStateIndex:5075; appliedIndex:5071; }","duration":"100.160102ms","start":"2026-05-26T15:57:17.586027Z","end":"2026-05-26T15:57:17.686187Z","steps":["trace[1426692576] 'read index received' (duration: 96.784701ms)","trace[1426692576] 'applied index is now lower than readState.Index' (duration: 3.373501ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:57:17.686333Z","caller":"traceutil/trace.go:171","msg":"trace[302809081] transaction","detail":"{read_only:false; response_revision:4893; number_of_response:1; }","duration":"110.711565ms","start":"2026-05-26T15:57:17.575587Z","end":"2026-05-26T15:57:17.686298Z","steps":["trace[302809081] 'process raft request' (duration: 110.333297ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:17.687346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.759825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-00076202-eb84-4b0a-a6cd-389a30ae4f72\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-05-26T15:57:17.687478Z","caller":"traceutil/trace.go:171","msg":"trace[1255062162] range","detail":"{range_begin:/registry/persistentvolumes/pvc-00076202-eb84-4b0a-a6cd-389a30ae4f72; range_end:; response_count:1; response_revision:4894; }","duration":"110.889428ms","start":"2026-05-26T15:57:17.576532Z","end":"2026-05-26T15:57:17.687421Z","steps":["trace[1255062162] 'agreement among raft nodes before linearized reading' (duration: 109.763381ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:24.875381Z","caller":"traceutil/trace.go:171","msg":"trace[214055618] transaction","detail":"{read_only:false; response_revision:5004; number_of_response:1; }","duration":"115.503712ms","start":"2026-05-26T15:57:24.759857Z","end":"2026-05-26T15:57:24.87536Z","steps":["trace[214055618] 'process raft request' (duration: 115.355558ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:30.673442Z","caller":"traceutil/trace.go:171","msg":"trace[625174261] transaction","detail":"{read_only:false; response_revision:5062; number_of_response:1; }","duration":"169.70941ms","start":"2026-05-26T15:57:30.503709Z","end":"2026-05-26T15:57:30.673418Z","steps":["trace[625174261] 'process raft request' (duration: 169.566957ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:30.701094Z","caller":"traceutil/trace.go:171","msg":"trace[751719767] linearizableReadLoop","detail":"{readStateIndex:5250; appliedIndex:5248; }","duration":"134.238385ms","start":"2026-05-26T15:57:30.566835Z","end":"2026-05-26T15:57:30.701073Z","steps":["trace[751719767] 'read index received' (duration: 106.56734ms)","trace[751719767] 'applied index is now lower than readState.Index' (duration: 27.670045ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:57:30.701196Z","caller":"traceutil/trace.go:171","msg":"trace[1116306113] transaction","detail":"{read_only:false; response_revision:5064; number_of_response:1; }","duration":"196.103073ms","start":"2026-05-26T15:57:30.505084Z","end":"2026-05-26T15:57:30.701187Z","steps":["trace[1116306113] 'process raft request' (duration: 195.95585ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:30.701376Z","caller":"traceutil/trace.go:171","msg":"trace[1739450411] transaction","detail":"{read_only:false; response_revision:5063; number_of_response:1; }","duration":"196.699227ms","start":"2026-05-26T15:57:30.504488Z","end":"2026-05-26T15:57:30.701187Z","steps":["trace[1739450411] 'process raft request' (duration: 196.420061ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:30.70158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.719296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-05-26T15:57:30.701645Z","caller":"traceutil/trace.go:171","msg":"trace[342284011] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5064; }","duration":"134.797138ms","start":"2026-05-26T15:57:30.56683Z","end":"2026-05-26T15:57:30.701627Z","steps":["trace[342284011] 'agreement among raft nodes before linearized reading' (duration: 134.425419ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:30.841747Z","caller":"traceutil/trace.go:171","msg":"trace[50771579] transaction","detail":"{read_only:false; response_revision:5065; number_of_response:1; }","duration":"137.514835ms","start":"2026-05-26T15:57:30.704187Z","end":"2026-05-26T15:57:30.841702Z","steps":["trace[50771579] 'process raft request' (duration: 55.028154ms)","trace[50771579] 'compare' (duration: 82.196854ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:57:55.640113Z","caller":"traceutil/trace.go:171","msg":"trace[1683628740] linearizableReadLoop","detail":"{readStateIndex:5410; appliedIndex:5409; }","duration":"279.466679ms","start":"2026-05-26T15:57:55.36063Z","end":"2026-05-26T15:57:55.640097Z","steps":["trace[1683628740] 'read index received' (duration: 277.538852ms)","trace[1683628740] 'applied index is now lower than readState.Index' (duration: 1.927047ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:57:55.640174Z","caller":"traceutil/trace.go:171","msg":"trace[1446789812] transaction","detail":"{read_only:false; response_revision:5219; number_of_response:1; }","duration":"281.09594ms","start":"2026-05-26T15:57:55.359064Z","end":"2026-05-26T15:57:55.64016Z","steps":["trace[1446789812] 'process raft request' (duration: 279.163372ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:55.640371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.714005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-26T15:57:55.640452Z","caller":"traceutil/trace.go:171","msg":"trace[182933354] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5219; }","duration":"279.844199ms","start":"2026-05-26T15:57:55.360589Z","end":"2026-05-26T15:57:55.640434Z","steps":["trace[182933354] 'agreement among raft nodes before linearized reading' (duration: 279.593753ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:55.64114Z","caller":"traceutil/trace.go:171","msg":"trace[1679870455] transaction","detail":"{read_only:false; response_revision:5220; number_of_response:1; }","duration":"133.868459ms","start":"2026-05-26T15:57:55.507261Z","end":"2026-05-26T15:57:55.641129Z","steps":["trace[1679870455] 'process raft request' (duration: 133.703985ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:55.641248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.394288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-26T15:57:55.641279Z","caller":"traceutil/trace.go:171","msg":"trace[181436783] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5220; }","duration":"265.4711ms","start":"2026-05-26T15:57:55.375801Z","end":"2026-05-26T15:57:55.641272Z","steps":["trace[181436783] 'agreement among raft nodes before linearized reading' (duration: 265.355758ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:55.641416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.409869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-26T15:57:55.641473Z","caller":"traceutil/trace.go:171","msg":"trace[680174893] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5220; }","duration":"269.512012ms","start":"2026-05-26T15:57:55.371947Z","end":"2026-05-26T15:57:55.641459Z","steps":["trace[680174893] 'agreement among raft nodes before linearized reading' (duration: 269.113902ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:55.952481Z","caller":"traceutil/trace.go:171","msg":"trace[1584784815] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5223; }","duration":"213.554806ms","start":"2026-05-26T15:57:55.738895Z","end":"2026-05-26T15:57:55.95245Z","steps":["trace[1584784815] 'process raft request' (duration: 213.428213ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:56.546377Z","caller":"traceutil/trace.go:171","msg":"trace[298942133] linearizableReadLoop","detail":"{readStateIndex:5417; appliedIndex:5416; }","duration":"318.53324ms","start":"2026-05-26T15:57:56.22782Z","end":"2026-05-26T15:57:56.546354Z","steps":["trace[298942133] 'read index received' (duration: 318.232942ms)","trace[298942133] 'applied index is now lower than readState.Index' (duration: 299.308µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:57:56.546455Z","caller":"traceutil/trace.go:171","msg":"trace[1676466248] transaction","detail":"{read_only:false; response_revision:5225; number_of_response:1; }","duration":"485.346864ms","start":"2026-05-26T15:57:56.061081Z","end":"2026-05-26T15:57:56.546428Z","steps":["trace[1676466248] 'process raft request' (duration: 485.092347ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:56.546547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.713114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:57:56.546611Z","caller":"traceutil/trace.go:171","msg":"trace[1496727772] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5225; }","duration":"318.833667ms","start":"2026-05-26T15:57:56.227766Z","end":"2026-05-26T15:57:56.5466Z","steps":["trace[1496727772] 'agreement among raft nodes before linearized reading' (duration: 318.714274ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:56.546639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:57:56.061031Z","time spent":"485.482867ms","remote":"127.0.0.1:60532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":71840,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T15:57:56.546654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:57:56.227746Z","time spent":"318.900309ms","remote":"127.0.0.1:60406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-26T15:57:56.54689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.338243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-05-26T15:57:56.54703Z","caller":"traceutil/trace.go:171","msg":"trace[2013660431] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5225; }","duration":"126.475037ms","start":"2026-05-26T15:57:56.420479Z","end":"2026-05-26T15:57:56.546954Z","steps":["trace[2013660431] 'agreement among raft nodes before linearized reading' (duration: 126.228611ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:57.45454Z","caller":"traceutil/trace.go:171","msg":"trace[1934613537] linearizableReadLoop","detail":"{readStateIndex:5497; appliedIndex:5497; }","duration":"431.233511ms","start":"2026-05-26T15:57:57.02329Z","end":"2026-05-26T15:57:57.454524Z","steps":["trace[1934613537] 'read index received' (duration: 431.228011ms)","trace[1934613537] 'applied index is now lower than readState.Index' (duration: 4.59µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:57:57.454704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.411106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-05-26T15:57:57.454726Z","caller":"traceutil/trace.go:171","msg":"trace[1970210783] range","detail":"{range_begin:/registry/serviceaccounts/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:5305; }","duration":"431.533499ms","start":"2026-05-26T15:57:57.023185Z","end":"2026-05-26T15:57:57.454719Z","steps":["trace[1970210783] 'agreement among raft nodes before linearized reading' (duration: 431.430496ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:57.454746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:57:57.023168Z","time spent":"431.574559ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":576,"request content":"key:\"/registry/serviceaccounts/openstack/keystone-credential-setup\" "} {"level":"info","ts":"2026-05-26T15:57:57.454547Z","caller":"traceutil/trace.go:171","msg":"trace[67381181] transaction","detail":"{read_only:false; response_revision:5305; number_of_response:1; }","duration":"437.837296ms","start":"2026-05-26T15:57:57.016693Z","end":"2026-05-26T15:57:57.45453Z","steps":["trace[67381181] 'process raft request' (duration: 437.686062ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:57.455081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:57:57.016671Z","time spent":"438.318507ms","remote":"127.0.0.1:57248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7367,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:57:57.458169Z","caller":"traceutil/trace.go:171","msg":"trace[274165769] transaction","detail":"{read_only:false; response_revision:5307; number_of_response:1; }","duration":"391.454588ms","start":"2026-05-26T15:57:57.066688Z","end":"2026-05-26T15:57:57.458142Z","steps":["trace[274165769] 'process raft request' (duration: 390.991047ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:57.458309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:57:57.066681Z","time spent":"391.55641ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:57:57.45825Z","caller":"traceutil/trace.go:171","msg":"trace[887520282] transaction","detail":"{read_only:false; response_revision:5308; number_of_response:1; }","duration":"190.903079ms","start":"2026-05-26T15:57:57.267305Z","end":"2026-05-26T15:57:57.458208Z","steps":["trace[887520282] 'process raft request' (duration: 190.462938ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:57.458501Z","caller":"traceutil/trace.go:171","msg":"trace[915086134] transaction","detail":"{read_only:false; response_revision:5306; number_of_response:1; }","duration":"391.95481ms","start":"2026-05-26T15:57:57.066515Z","end":"2026-05-26T15:57:57.45847Z","steps":["trace[915086134] 'process raft request' (duration: 391.091149ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:57.458678Z","caller":"traceutil/trace.go:171","msg":"trace[2036216153] transaction","detail":"{read_only:false; response_revision:5310; number_of_response:1; }","duration":"150.071608ms","start":"2026-05-26T15:57:57.308599Z","end":"2026-05-26T15:57:57.45867Z","steps":["trace[2036216153] 'process raft request' (duration: 149.218387ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:57.458808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:57:57.066496Z","time spent":"392.173385ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:57:57.458629Z","caller":"traceutil/trace.go:171","msg":"trace[402236297] transaction","detail":"{read_only:false; response_revision:5309; number_of_response:1; }","duration":"161.180996ms","start":"2026-05-26T15:57:57.297437Z","end":"2026-05-26T15:57:57.458618Z","steps":["trace[402236297] 'process raft request' (duration: 160.357346ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:58.385061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"927.170405ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-26T15:57:58.387242Z","caller":"traceutil/trace.go:171","msg":"trace[826145794] linearizableReadLoop","detail":"{readStateIndex:5503; appliedIndex:5497; }","duration":"932.611021ms","start":"2026-05-26T15:57:57.454602Z","end":"2026-05-26T15:57:58.387213Z","steps":["trace[826145794] 'read index received' (duration: 2.976824ms)","trace[826145794] 'applied index is now lower than readState.Index' (duration: 929.632257ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T15:57:58.387454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.019913981s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-05-26T15:57:58.387491Z","caller":"traceutil/trace.go:171","msg":"trace[1020183166] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5310; }","duration":"1.019983794s","start":"2026-05-26T15:57:57.367497Z","end":"2026-05-26T15:57:58.387481Z","steps":["trace[1020183166] 'agreement among raft nodes before linearized reading' (duration: 1.0198448s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:58.387524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:57:57.36749Z","time spent":"1.020024944s","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":552,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-05-26T15:57:58.388402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.147146199s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206973"} {"level":"info","ts":"2026-05-26T15:57:58.388458Z","caller":"traceutil/trace.go:171","msg":"trace[713610566] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5310; }","duration":"1.147229101s","start":"2026-05-26T15:57:57.241217Z","end":"2026-05-26T15:57:58.388446Z","steps":["trace[713610566] 'agreement among raft nodes before linearized reading' (duration: 1.146387781s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:58.388492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:57:57.241203Z","time spent":"1.147279192s","remote":"127.0.0.1:60536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2206995,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"warn","ts":"2026-05-26T15:57:58.388508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.243965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-26T15:57:58.38858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.155337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:57:58.388581Z","caller":"traceutil/trace.go:171","msg":"trace[496191938] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:5310; }","duration":"348.361077ms","start":"2026-05-26T15:57:58.040199Z","end":"2026-05-26T15:57:58.38856Z","steps":["trace[496191938] 'agreement among raft nodes before linearized reading' (duration: 348.199073ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:58.388623Z","caller":"traceutil/trace.go:171","msg":"trace[1038372437] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5310; }","duration":"431.221878ms","start":"2026-05-26T15:57:57.957383Z","end":"2026-05-26T15:57:58.388605Z","steps":["trace[1038372437] 'agreement among raft nodes before linearized reading' (duration: 431.174837ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:58.38863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:57:58.040179Z","time spent":"348.43972ms","remote":"127.0.0.1:60926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":10,"response size":29,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"warn","ts":"2026-05-26T15:57:58.388659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:57:57.957365Z","time spent":"431.28725ms","remote":"127.0.0.1:60406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-26T15:57:58.388799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.296212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T15:57:58.388836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.888461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T15:57:58.38886Z","caller":"traceutil/trace.go:171","msg":"trace[2135143751] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5310; }","duration":"161.400054ms","start":"2026-05-26T15:57:58.227444Z","end":"2026-05-26T15:57:58.388844Z","steps":["trace[2135143751] 'agreement among raft nodes before linearized reading' (duration: 161.297932ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:58.388873Z","caller":"traceutil/trace.go:171","msg":"trace[1402364773] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:5310; }","duration":"282.958803ms","start":"2026-05-26T15:57:58.105903Z","end":"2026-05-26T15:57:58.388862Z","steps":["trace[1402364773] 'agreement among raft nodes before linearized reading' (duration: 282.899731ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:58.388908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"739.457377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-26T15:57:58.388942Z","caller":"traceutil/trace.go:171","msg":"trace[48594368] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5310; }","duration":"739.503468ms","start":"2026-05-26T15:57:57.649429Z","end":"2026-05-26T15:57:58.388932Z","steps":["trace[48594368] 'agreement among raft nodes before linearized reading' (duration: 739.407246ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:58.388971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:57:57.649422Z","time spent":"739.542789ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T15:57:58.388523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"932.894988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keystone-credential-setup-8lc6n\" ","response":"range_response_count:1 size:7406"} {"level":"info","ts":"2026-05-26T15:57:58.389015Z","caller":"traceutil/trace.go:171","msg":"trace[572610475] range","detail":"{range_begin:/registry/pods/openstack/keystone-credential-setup-8lc6n; range_end:; response_count:1; response_revision:5310; }","duration":"933.426061ms","start":"2026-05-26T15:57:57.455578Z","end":"2026-05-26T15:57:58.389004Z","steps":["trace[572610475] 'agreement among raft nodes before linearized reading' (duration: 932.813406ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:58.389047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:57:57.455565Z","time spent":"933.472712ms","remote":"127.0.0.1:60606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":7428,"request content":"key:\"/registry/pods/openstack/keystone-credential-setup-8lc6n\" "} {"level":"warn","ts":"2026-05-26T15:57:58.389116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.272365898s","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-05-26T15:57:58.389144Z","caller":"traceutil/trace.go:171","msg":"trace[393478053] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5310; }","duration":"1.27245217s","start":"2026-05-26T15:57:57.116683Z","end":"2026-05-26T15:57:58.389136Z","steps":["trace[393478053] 'agreement among raft nodes before linearized reading' (duration: 1.272342857s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:58.389149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"739.713575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-05-26T15:57:58.389171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:57:57.116664Z","time spent":"1.272500511s","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-26T15:57:58.389178Z","caller":"traceutil/trace.go:171","msg":"trace[1679783479] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5310; }","duration":"739.741465ms","start":"2026-05-26T15:57:57.649428Z","end":"2026-05-26T15:57:58.389169Z","steps":["trace[1679783479] 'agreement among raft nodes before linearized reading' (duration: 739.652353ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:58.389207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:57:57.649399Z","time spent":"739.801587ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-26T15:57:58.389406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.007496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-26T15:57:58.389443Z","caller":"traceutil/trace.go:171","msg":"trace[812815539] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5310; }","duration":"741.082068ms","start":"2026-05-26T15:57:57.648352Z","end":"2026-05-26T15:57:58.389434Z","steps":["trace[812815539] 'agreement among raft nodes before linearized reading' (duration: 740.988345ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:58.38947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:57:57.648331Z","time spent":"741.13302ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T15:57:58.389673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.210341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-26T15:57:58.389701Z","caller":"traceutil/trace.go:171","msg":"trace[1019652472] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5310; }","duration":"745.280842ms","start":"2026-05-26T15:57:57.644412Z","end":"2026-05-26T15:57:58.389693Z","steps":["trace[1019652472] 'agreement among raft nodes before linearized reading' (duration: 745.20244ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:58.389727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:57:57.644386Z","time spent":"745.335544ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-26T15:57:59.747071Z","caller":"traceutil/trace.go:171","msg":"trace[209923478] transaction","detail":"{read_only:false; response_revision:5325; number_of_response:1; }","duration":"320.64461ms","start":"2026-05-26T15:57:59.426376Z","end":"2026-05-26T15:57:59.747021Z","steps":["trace[209923478] 'process raft request' (duration: 320.278001ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:57:59.747271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:57:59.426344Z","time spent":"320.821595ms","remote":"127.0.0.1:60606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12033,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:57:59.751232Z","caller":"traceutil/trace.go:171","msg":"trace[1673145294] transaction","detail":"{read_only:false; response_revision:5327; number_of_response:1; }","duration":"286.170508ms","start":"2026-05-26T15:57:59.465037Z","end":"2026-05-26T15:57:59.751208Z","steps":["trace[1673145294] 'process raft request' (duration: 286.090506ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:59.75145Z","caller":"traceutil/trace.go:171","msg":"trace[415555277] transaction","detail":"{read_only:false; response_revision:5328; number_of_response:1; }","duration":"286.26114ms","start":"2026-05-26T15:57:59.465173Z","end":"2026-05-26T15:57:59.751434Z","steps":["trace[415555277] 'process raft request' (duration: 285.993683ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:59.751461Z","caller":"traceutil/trace.go:171","msg":"trace[1693373871] transaction","detail":"{read_only:false; response_revision:5326; number_of_response:1; }","duration":"287.578254ms","start":"2026-05-26T15:57:59.46385Z","end":"2026-05-26T15:57:59.751428Z","steps":["trace[1693373871] 'process raft request' (duration: 287.171404ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:57:59.751894Z","caller":"traceutil/trace.go:171","msg":"trace[1889911699] transaction","detail":"{read_only:false; response_revision:5329; number_of_response:1; }","duration":"286.614449ms","start":"2026-05-26T15:57:59.465246Z","end":"2026-05-26T15:57:59.751861Z","steps":["trace[1889911699] 'process raft request' (duration: 286.132248ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:58:18.208438Z","caller":"traceutil/trace.go:171","msg":"trace[1711892559] transaction","detail":"{read_only:false; response_revision:5454; number_of_response:1; }","duration":"385.993951ms","start":"2026-05-26T15:58:17.822411Z","end":"2026-05-26T15:58:18.208405Z","steps":["trace[1711892559] 'process raft request' (duration: 385.705613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:58:18.208664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:58:17.822391Z","time spent":"386.137764ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:58:18.241589Z","caller":"traceutil/trace.go:171","msg":"trace[909916589] transaction","detail":"{read_only:false; response_revision:5456; number_of_response:1; }","duration":"412.205836ms","start":"2026-05-26T15:58:17.829348Z","end":"2026-05-26T15:58:18.241553Z","steps":["trace[909916589] 'process raft request' (duration: 412.131394ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:58:18.241689Z","caller":"traceutil/trace.go:171","msg":"trace[1152861572] transaction","detail":"{read_only:false; response_revision:5455; number_of_response:1; }","duration":"412.794831ms","start":"2026-05-26T15:58:17.828857Z","end":"2026-05-26T15:58:18.241652Z","steps":["trace[1152861572] 'process raft request' (duration: 412.493883ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:58:18.241743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:58:17.829326Z","time spent":"412.347579ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T15:58:18.241847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:58:17.828845Z","time spent":"412.919443ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:58:18.241911Z","caller":"traceutil/trace.go:171","msg":"trace[361879308] transaction","detail":"{read_only:false; response_revision:5457; number_of_response:1; }","duration":"411.170379ms","start":"2026-05-26T15:58:17.830729Z","end":"2026-05-26T15:58:18.2419Z","steps":["trace[361879308] 'process raft request' (duration: 410.79651ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:58:18.241957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:58:17.830717Z","time spent":"411.214871ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T15:58:18.241953Z","caller":"traceutil/trace.go:171","msg":"trace[482836974] linearizableReadLoop","detail":"{readStateIndex:5655; appliedIndex:5650; }","duration":"284.149691ms","start":"2026-05-26T15:58:17.957777Z","end":"2026-05-26T15:58:18.241927Z","steps":["trace[482836974] 'read index received' (duration: 250.323464ms)","trace[482836974] 'applied index is now lower than readState.Index' (duration: 33.825487ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T15:58:18.241998Z","caller":"traceutil/trace.go:171","msg":"trace[74020646] transaction","detail":"{read_only:false; response_revision:5458; number_of_response:1; }","duration":"365.117503ms","start":"2026-05-26T15:58:17.876869Z","end":"2026-05-26T15:58:18.241986Z","steps":["trace[74020646] 'process raft request' (duration: 364.901978ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T15:58:18.242046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T15:58:17.876843Z","time spent":"365.176254ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T15:58:18.242987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.153157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T15:58:18.24318Z","caller":"traceutil/trace.go:171","msg":"trace[258531952] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5459; }","duration":"285.415534ms","start":"2026-05-26T15:58:17.95774Z","end":"2026-05-26T15:58:18.243156Z","steps":["trace[258531952] 'agreement among raft nodes before linearized reading' (duration: 285.109157ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T15:58:39.054536Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2920} {"level":"info","ts":"2026-05-26T15:58:39.170951Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2920,"took":"114.560421ms","hash":1848896570,"current-db-size-bytes":52916224,"current-db-size":"53 MB","current-db-size-in-use-bytes":29224960,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-26T15:58:39.171002Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1848896570,"revision":2920,"compact-revision":-1} {"level":"info","ts":"2026-05-26T16:02:05.922374Z","caller":"traceutil/trace.go:171","msg":"trace[158689446] transaction","detail":"{read_only:false; response_revision:7007; number_of_response:1; }","duration":"178.557916ms","start":"2026-05-26T16:02:05.743776Z","end":"2026-05-26T16:02:05.922334Z","steps":["trace[158689446] 'process raft request' (duration: 79.991706ms)","trace[158689446] 'compare' (duration: 98.444806ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T16:02:05.928133Z","caller":"traceutil/trace.go:171","msg":"trace[776300877] transaction","detail":"{read_only:false; response_revision:7008; number_of_response:1; }","duration":"182.375668ms","start":"2026-05-26T16:02:05.745736Z","end":"2026-05-26T16:02:05.928112Z","steps":["trace[776300877] 'process raft request' (duration: 182.219164ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T16:02:05.928279Z","caller":"traceutil/trace.go:171","msg":"trace[2071930233] linearizableReadLoop","detail":"{readStateIndex:7262; appliedIndex:7259; }","duration":"167.408663ms","start":"2026-05-26T16:02:05.760842Z","end":"2026-05-26T16:02:05.928251Z","steps":["trace[2071930233] 'read index received' (duration: 63.038936ms)","trace[2071930233] 'applied index is now lower than readState.Index' (duration: 104.368257ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T16:02:05.928494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.638329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T16:02:05.928736Z","caller":"traceutil/trace.go:171","msg":"trace[1501518415] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:7009; }","duration":"167.912016ms","start":"2026-05-26T16:02:05.760805Z","end":"2026-05-26T16:02:05.928717Z","steps":["trace[1501518415] 'agreement among raft nodes before linearized reading' (duration: 167.636309ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T16:02:05.928505Z","caller":"traceutil/trace.go:171","msg":"trace[512767844] transaction","detail":"{read_only:false; response_revision:7009; number_of_response:1; }","duration":"182.112761ms","start":"2026-05-26T16:02:05.746338Z","end":"2026-05-26T16:02:05.92845Z","steps":["trace[512767844] 'process raft request' (duration: 181.733071ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T16:02:05.9291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.833511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"warn","ts":"2026-05-26T16:02:05.929187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.646207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-26T16:02:05.929363Z","caller":"traceutil/trace.go:171","msg":"trace[302439976] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7009; }","duration":"154.851723ms","start":"2026-05-26T16:02:05.774496Z","end":"2026-05-26T16:02:05.929348Z","steps":["trace[302439976] 'agreement among raft nodes before linearized reading' (duration: 154.547395ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T16:02:05.929364Z","caller":"traceutil/trace.go:171","msg":"trace[54232753] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7009; }","duration":"158.981345ms","start":"2026-05-26T16:02:05.770206Z","end":"2026-05-26T16:02:05.929187Z","steps":["trace[54232753] 'agreement among raft nodes before linearized reading' (duration: 158.525113ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T16:02:07.303471Z","caller":"traceutil/trace.go:171","msg":"trace[433180582] transaction","detail":"{read_only:false; response_revision:7012; number_of_response:1; }","duration":"146.705954ms","start":"2026-05-26T16:02:07.156734Z","end":"2026-05-26T16:02:07.30344Z","steps":["trace[433180582] 'process raft request' (duration: 46.827348ms)","trace[433180582] 'compare' (duration: 99.461304ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T16:02:07.303486Z","caller":"traceutil/trace.go:171","msg":"trace[1669978354] transaction","detail":"{read_only:false; response_revision:7013; number_of_response:1; }","duration":"136.152368ms","start":"2026-05-26T16:02:07.167311Z","end":"2026-05-26T16:02:07.303464Z","steps":["trace[1669978354] 'process raft request' (duration: 136.035705ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T16:02:07.303672Z","caller":"traceutil/trace.go:171","msg":"trace[1400566288] transaction","detail":"{read_only:false; response_revision:7014; number_of_response:1; }","duration":"135.49795ms","start":"2026-05-26T16:02:07.168156Z","end":"2026-05-26T16:02:07.303654Z","steps":["trace[1400566288] 'process raft request' (duration: 135.275085ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T16:02:12.094947Z","caller":"traceutil/trace.go:171","msg":"trace[224206305] linearizableReadLoop","detail":"{readStateIndex:7291; appliedIndex:7290; }","duration":"144.433794ms","start":"2026-05-26T16:02:11.950491Z","end":"2026-05-26T16:02:12.094924Z","steps":["trace[224206305] 'read index received' (duration: 144.290101ms)","trace[224206305] 'applied index is now lower than readState.Index' (duration: 142.783µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T16:02:12.095051Z","caller":"traceutil/trace.go:171","msg":"trace[254862618] transaction","detail":"{read_only:false; response_revision:7037; number_of_response:1; }","duration":"145.05097ms","start":"2026-05-26T16:02:11.949986Z","end":"2026-05-26T16:02:12.095037Z","steps":["trace[254862618] 'process raft request' (duration: 144.782573ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T16:02:12.095692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.175454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-26T16:02:12.095774Z","caller":"traceutil/trace.go:171","msg":"trace[123402732] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7037; }","duration":"145.290087ms","start":"2026-05-26T16:02:11.950464Z","end":"2026-05-26T16:02:12.095754Z","steps":["trace[123402732] 'agreement among raft nodes before linearized reading' (duration: 144.596558ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T16:02:12.26004Z","caller":"traceutil/trace.go:171","msg":"trace[1573894422] linearizableReadLoop","detail":"{readStateIndex:7292; appliedIndex:7291; }","duration":"164.994081ms","start":"2026-05-26T16:02:12.09501Z","end":"2026-05-26T16:02:12.260004Z","steps":["trace[1573894422] 'read index received' (duration: 161.176057ms)","trace[1573894422] 'applied index is now lower than readState.Index' (duration: 3.816394ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T16:02:12.260323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.608713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-client-secret\" ","response":"range_response_count:1 size:692"} {"level":"warn","ts":"2026-05-26T16:02:12.260402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.280681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-26T16:02:12.260414Z","caller":"traceutil/trace.go:171","msg":"trace[82316213] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-client-secret; range_end:; response_count:1; response_revision:7038; }","duration":"180.737697ms","start":"2026-05-26T16:02:12.079654Z","end":"2026-05-26T16:02:12.260392Z","steps":["trace[82316213] 'agreement among raft nodes before linearized reading' (duration: 180.515551ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T16:02:12.260445Z","caller":"traceutil/trace.go:171","msg":"trace[1306153505] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7038; }","duration":"257.373474ms","start":"2026-05-26T16:02:12.00306Z","end":"2026-05-26T16:02:12.260434Z","steps":["trace[1306153505] 'agreement among raft nodes before linearized reading' (duration: 257.052076ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T16:02:12.260496Z","caller":"traceutil/trace.go:171","msg":"trace[1669563591] transaction","detail":"{read_only:false; response_revision:7038; number_of_response:1; }","duration":"309.786283ms","start":"2026-05-26T16:02:11.950687Z","end":"2026-05-26T16:02:12.260474Z","steps":["trace[1669563591] 'process raft request' (duration: 305.477647ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T16:02:12.260775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.683638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.153\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-26T16:02:12.260854Z","caller":"traceutil/trace.go:171","msg":"trace[445480902] range","detail":"{range_begin:/registry/masterleases/199.19.213.153; range_end:; response_count:1; response_revision:7038; }","duration":"231.800021ms","start":"2026-05-26T16:02:12.029033Z","end":"2026-05-26T16:02:12.260833Z","steps":["trace[445480902] 'agreement among raft nodes before linearized reading' (duration: 231.580645ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T16:02:12.260987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T16:02:11.950665Z","time spent":"309.893246ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T16:02:12.271107Z","caller":"traceutil/trace.go:171","msg":"trace[1298048895] transaction","detail":"{read_only:false; response_revision:7039; number_of_response:1; }","duration":"169.071951ms","start":"2026-05-26T16:02:12.102007Z","end":"2026-05-26T16:02:12.271079Z","steps":["trace[1298048895] 'process raft request' (duration: 168.913747ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T16:02:12.384873Z","caller":"traceutil/trace.go:171","msg":"trace[1872747222] transaction","detail":"{read_only:false; response_revision:7040; number_of_response:1; }","duration":"119.782136ms","start":"2026-05-26T16:02:12.265064Z","end":"2026-05-26T16:02:12.384846Z","steps":["trace[1872747222] 'process raft request' (duration: 119.643491ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T16:02:12.589247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.454222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-05-26T16:02:12.589432Z","caller":"traceutil/trace.go:171","msg":"trace[1467706384] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:7041; }","duration":"103.681009ms","start":"2026-05-26T16:02:12.48573Z","end":"2026-05-26T16:02:12.589411Z","steps":["trace[1467706384] 'range keys from in-memory index tree' (duration: 103.281948ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T16:02:37.451721Z","caller":"traceutil/trace.go:171","msg":"trace[624337406] linearizableReadLoop","detail":"{readStateIndex:7422; appliedIndex:7421; }","duration":"224.205422ms","start":"2026-05-26T16:02:37.227487Z","end":"2026-05-26T16:02:37.451693Z","steps":["trace[624337406] 'read index received' (duration: 224.016327ms)","trace[624337406] 'applied index is now lower than readState.Index' (duration: 187.875µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T16:02:37.451854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.343755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T16:02:37.452295Z","caller":"traceutil/trace.go:171","msg":"trace[650466622] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7163; }","duration":"224.813975ms","start":"2026-05-26T16:02:37.227456Z","end":"2026-05-26T16:02:37.45227Z","steps":["trace[650466622] 'agreement among raft nodes before linearized reading' (duration: 224.331625ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T16:02:37.451771Z","caller":"traceutil/trace.go:171","msg":"trace[1367244773] transaction","detail":"{read_only:false; response_revision:7163; number_of_response:1; }","duration":"245.782615ms","start":"2026-05-26T16:02:37.20596Z","end":"2026-05-26T16:02:37.451743Z","steps":["trace[1367244773] 'process raft request' (duration: 245.556419ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T16:02:37.614631Z","caller":"traceutil/trace.go:171","msg":"trace[1183630246] transaction","detail":"{read_only:false; response_revision:7164; number_of_response:1; }","duration":"189.149428ms","start":"2026-05-26T16:02:37.425448Z","end":"2026-05-26T16:02:37.614597Z","steps":["trace[1183630246] 'process raft request' (duration: 188.886002ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T16:02:37.614766Z","caller":"traceutil/trace.go:171","msg":"trace[1036858446] transaction","detail":"{read_only:false; response_revision:7166; number_of_response:1; }","duration":"179.217889ms","start":"2026-05-26T16:02:37.43553Z","end":"2026-05-26T16:02:37.614748Z","steps":["trace[1036858446] 'process raft request' (duration: 178.999924ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T16:02:37.614958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.814744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T16:02:37.615012Z","caller":"traceutil/trace.go:171","msg":"trace[254626875] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7166; }","duration":"160.883405ms","start":"2026-05-26T16:02:37.454114Z","end":"2026-05-26T16:02:37.614998Z","steps":["trace[254626875] 'agreement among raft nodes before linearized reading' (duration: 160.784413ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T16:02:37.614757Z","caller":"traceutil/trace.go:171","msg":"trace[1621921149] transaction","detail":"{read_only:false; response_revision:7165; number_of_response:1; }","duration":"180.907054ms","start":"2026-05-26T16:02:37.433808Z","end":"2026-05-26T16:02:37.614715Z","steps":["trace[1621921149] 'process raft request' (duration: 180.641669ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T16:02:37.614861Z","caller":"traceutil/trace.go:171","msg":"trace[177340068] linearizableReadLoop","detail":"{readStateIndex:7426; appliedIndex:7422; }","duration":"160.542648ms","start":"2026-05-26T16:02:37.454125Z","end":"2026-05-26T16:02:37.614667Z","steps":["trace[177340068] 'read index received' (duration: 107.571117ms)","trace[177340068] 'applied index is now lower than readState.Index' (duration: 52.970481ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T16:03:39.060534Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5628} {"level":"info","ts":"2026-05-26T16:03:39.146606Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5628,"took":"82.495412ms","hash":3397296894,"current-db-size-bytes":52916224,"current-db-size":"53 MB","current-db-size-in-use-bytes":18612224,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-05-26T16:03:39.146714Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3397296894,"revision":5628,"compact-revision":2920} {"level":"warn","ts":"2026-05-26T16:04:46.403381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.475835ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T16:04:46.403621Z","caller":"traceutil/trace.go:171","msg":"trace[572360531] linearizableReadLoop","detail":"{readStateIndex:8102; appliedIndex:8100; }","duration":"335.529905ms","start":"2026-05-26T16:04:46.068075Z","end":"2026-05-26T16:04:46.403605Z","steps":["trace[572360531] 'read index received' (duration: 22.331µs)","trace[572360531] 'applied index is now lower than readState.Index' (duration: 335.506754ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T16:04:46.403634Z","caller":"traceutil/trace.go:171","msg":"trace[907008623] transaction","detail":"{read_only:false; response_revision:7815; number_of_response:1; }","duration":"352.730425ms","start":"2026-05-26T16:04:46.050878Z","end":"2026-05-26T16:04:46.403608Z","steps":["trace[907008623] 'compare' (duration: 348.086166ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T16:04:46.403765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T16:04:46.050869Z","time spent":"352.829287ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T16:04:46.403759Z","caller":"traceutil/trace.go:171","msg":"trace[419717954] transaction","detail":"{read_only:false; response_revision:7816; number_of_response:1; }","duration":"352.749075ms","start":"2026-05-26T16:04:46.050981Z","end":"2026-05-26T16:04:46.40373Z","steps":["trace[419717954] 'process raft request' (duration: 352.53987ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T16:04:46.403945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.836763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/kube-public/\" range_end:\"/registry/cronjobs/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T16:04:46.403983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T16:04:46.050975Z","time spent":"352.929109ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T16:04:46.404022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.3281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-leader-election-rolebinding\" ","response":"range_response_count:1 size:1146"} {"level":"info","ts":"2026-05-26T16:04:46.404033Z","caller":"traceutil/trace.go:171","msg":"trace[2077791126] range","detail":"{range_begin:/registry/cronjobs/kube-public/; range_end:/registry/cronjobs/kube-public0; response_count:0; response_revision:7816; }","duration":"335.965485ms","start":"2026-05-26T16:04:46.068047Z","end":"2026-05-26T16:04:46.404012Z","steps":["trace[2077791126] 'agreement among raft nodes before linearized reading' (duration: 335.781371ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T16:04:46.40406Z","caller":"traceutil/trace.go:171","msg":"trace[322299172] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-leader-election-rolebinding; range_end:; response_count:1; response_revision:7816; }","duration":"270.376781ms","start":"2026-05-26T16:04:46.133673Z","end":"2026-05-26T16:04:46.40405Z","steps":["trace[322299172] 'agreement among raft nodes before linearized reading' (duration: 270.249308ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T16:04:46.404036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.815836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-public/\" range_end:\"/registry/daemonsets/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T16:04:46.404081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T16:04:46.068033Z","time spent":"336.036426ms","remote":"127.0.0.1:60686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":27,"request content":"key:\"/registry/cronjobs/kube-public/\" range_end:\"/registry/cronjobs/kube-public0\" limit:500 "} {"level":"info","ts":"2026-05-26T16:04:46.404125Z","caller":"traceutil/trace.go:171","msg":"trace[487848532] range","detail":"{range_begin:/registry/daemonsets/kube-public/; range_end:/registry/daemonsets/kube-public0; response_count:0; response_revision:7816; }","duration":"299.965618ms","start":"2026-05-26T16:04:46.10414Z","end":"2026-05-26T16:04:46.404105Z","steps":["trace[487848532] 'agreement among raft nodes before linearized reading' (duration: 299.768944ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T16:04:46.404146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.777264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-infra-manager\" ","response":"range_response_count:1 size:1111"} {"level":"warn","ts":"2026-05-26T16:04:46.404172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T16:04:46.10412Z","time spent":"300.041751ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":27,"request content":"key:\"/registry/daemonsets/kube-public/\" range_end:\"/registry/daemonsets/kube-public0\" limit:500 "} {"level":"info","ts":"2026-05-26T16:04:46.404196Z","caller":"traceutil/trace.go:171","msg":"trace[1210159497] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-infra-manager; range_end:; response_count:1; response_revision:7816; }","duration":"293.863536ms","start":"2026-05-26T16:04:46.11032Z","end":"2026-05-26T16:04:46.404184Z","steps":["trace[1210159497] 'agreement among raft nodes before linearized reading' (duration: 293.724283ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T16:04:46.404727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.537415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T16:04:46.4048Z","caller":"traceutil/trace.go:171","msg":"trace[2124418005] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7816; }","duration":"177.656638ms","start":"2026-05-26T16:04:46.227125Z","end":"2026-05-26T16:04:46.404781Z","steps":["trace[2124418005] 'agreement among raft nodes before linearized reading' (duration: 177.086864ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T16:04:46.928579Z","caller":"traceutil/trace.go:171","msg":"trace[1110463877] linearizableReadLoop","detail":"{readStateIndex:8103; appliedIndex:8102; }","duration":"441.338793ms","start":"2026-05-26T16:04:46.487193Z","end":"2026-05-26T16:04:46.928532Z","steps":["trace[1110463877] 'read index received' (duration: 441.116818ms)","trace[1110463877] 'applied index is now lower than readState.Index' (duration: 220.965µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T16:04:46.928961Z","caller":"traceutil/trace.go:171","msg":"trace[90405397] transaction","detail":"{read_only:false; response_revision:7817; number_of_response:1; }","duration":"448.465998ms","start":"2026-05-26T16:04:46.480478Z","end":"2026-05-26T16:04:46.928944Z","steps":["trace[90405397] 'process raft request' (duration: 447.898475ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T16:04:46.929082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T16:04:46.480456Z","time spent":"448.54623ms","remote":"127.0.0.1:60698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T16:04:46.929362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.160063ms","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-05-26T16:04:46.929415Z","caller":"traceutil/trace.go:171","msg":"trace[1996284415] range","detail":"{range_begin:/registry/deployments/kube-public/; range_end:/registry/deployments/kube-public0; response_count:0; response_revision:7817; }","duration":"442.239134ms","start":"2026-05-26T16:04:46.48716Z","end":"2026-05-26T16:04:46.929399Z","steps":["trace[1996284415] 'agreement among raft nodes before linearized reading' (duration: 442.153032ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T16:04:46.92946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T16:04:46.487146Z","time spent":"442.300255ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":0,"response size":27,"request content":"key:\"/registry/deployments/kube-public/\" range_end:\"/registry/deployments/kube-public0\" limit:500 "} {"level":"warn","ts":"2026-05-26T16:04:46.929618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.085063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-leader-election-rolebinding\" ","response":"range_response_count:1 size:1146"} {"level":"info","ts":"2026-05-26T16:04:46.929687Z","caller":"traceutil/trace.go:171","msg":"trace[226497786] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-leader-election-rolebinding; range_end:; response_count:1; response_revision:7817; }","duration":"440.189586ms","start":"2026-05-26T16:04:46.489478Z","end":"2026-05-26T16:04:46.929668Z","steps":["trace[226497786] 'agreement among raft nodes before linearized reading' (duration: 439.989681ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T16:04:46.929729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T16:04:46.489463Z","time spent":"440.255097ms","remote":"127.0.0.1:60766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":1,"response size":1168,"request content":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-leader-election-rolebinding\" "} {"level":"warn","ts":"2026-05-26T16:04:46.929752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.710272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-26T16:04:46.929858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.219361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-infra-manager\" ","response":"range_response_count:1 size:1111"} {"level":"info","ts":"2026-05-26T16:04:46.92992Z","caller":"traceutil/trace.go:171","msg":"trace[468517136] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-infra-manager; range_end:; response_count:1; response_revision:7817; }","duration":"429.296562ms","start":"2026-05-26T16:04:46.500609Z","end":"2026-05-26T16:04:46.929905Z","steps":["trace[468517136] 'agreement among raft nodes before linearized reading' (duration: 429.129269ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T16:04:46.930359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T16:04:46.500602Z","time spent":"429.695162ms","remote":"127.0.0.1:60766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":1133,"request content":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-infra-manager\" "} {"level":"warn","ts":"2026-05-26T16:04:46.929937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.934088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/kube-public/\" range_end:\"/registry/services/endpoints/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T16:04:46.930753Z","caller":"traceutil/trace.go:171","msg":"trace[1109057844] range","detail":"{range_begin:/registry/services/endpoints/kube-public/; range_end:/registry/services/endpoints/kube-public0; response_count:0; response_revision:7817; }","duration":"430.767276ms","start":"2026-05-26T16:04:46.499967Z","end":"2026-05-26T16:04:46.930735Z","steps":["trace[1109057844] 'agreement among raft nodes before linearized reading' (duration: 429.937987ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T16:04:46.931031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T16:04:46.499957Z","time spent":"431.047444ms","remote":"127.0.0.1:60588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":27,"request content":"key:\"/registry/services/endpoints/kube-public/\" range_end:\"/registry/services/endpoints/kube-public0\" limit:500 "} {"level":"warn","ts":"2026-05-26T16:04:46.929937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.48757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-26T16:04:46.931172Z","caller":"traceutil/trace.go:171","msg":"trace[198248980] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7817; }","duration":"143.816582ms","start":"2026-05-26T16:04:46.787336Z","end":"2026-05-26T16:04:46.931152Z","steps":["trace[198248980] 'agreement among raft nodes before linearized reading' (duration: 142.389008ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T16:04:46.929848Z","caller":"traceutil/trace.go:171","msg":"trace[1493047075] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:7817; }","duration":"209.863266ms","start":"2026-05-26T16:04:46.71996Z","end":"2026-05-26T16:04:46.929824Z","steps":["trace[1493047075] 'agreement among raft nodes before linearized reading' (duration: 209.667571ms)"],"step_count":1}