{"level":"warn","ts":"2026-05-26T05:39:11.19563Z","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-26T05:39:11.195731Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.132:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.132:2380","--initial-cluster=instance=https://199.204.45.132:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.132:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.132: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-26T05:39:11.195809Z","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-26T05:39:11.195832Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.132:2380"]} {"level":"info","ts":"2026-05-26T05:39:11.195852Z","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-26T05:39:11.196578Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"]} {"level":"info","ts":"2026-05-26T05:39:11.196665Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.132: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-26T05:39:11.201522Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.620177ms"} {"level":"info","ts":"2026-05-26T05:39:11.207762Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"56c01ea8fdc90390","cluster-id":"c930fe821aab8609"} {"level":"info","ts":"2026-05-26T05:39:11.20785Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=()"} {"level":"info","ts":"2026-05-26T05:39:11.207887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 0"} {"level":"info","ts":"2026-05-26T05:39:11.207901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 56c01ea8fdc90390 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-26T05:39:11.207914Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 1"} {"level":"info","ts":"2026-05-26T05:39:11.20796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"warn","ts":"2026-05-26T05:39:11.225315Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-26T05:39:11.227328Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-26T05:39:11.229851Z","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-26T05:39:11.232366Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"56c01ea8fdc90390","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-26T05:39:11.233085Z","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-26T05:39:11.233158Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"56c01ea8fdc90390","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-26T05:39:11.233253Z","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-26T05:39:11.233268Z","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-26T05:39:11.235246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"info","ts":"2026-05-26T05:39:11.235448Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","added-peer-id":"56c01ea8fdc90390","added-peer-peer-urls":["https://199.204.45.132:2380"]} {"level":"info","ts":"2026-05-26T05:39:11.236855Z","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-26T05:39:11.236973Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-05-26T05:39:11.237033Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-05-26T05:39:11.237095Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"56c01ea8fdc90390","initial-advertise-peer-urls":["https://199.204.45.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-26T05:39:11.237191Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-26T05:39:11.308606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 is starting a new election at term 1"} {"level":"info","ts":"2026-05-26T05:39:11.308682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-26T05:39:11.308712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgPreVoteResp from 56c01ea8fdc90390 at term 1"} {"level":"info","ts":"2026-05-26T05:39:11.308732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became candidate at term 2"} {"level":"info","ts":"2026-05-26T05:39:11.308742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgVoteResp from 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-05-26T05:39:11.308754Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became leader at term 2"} {"level":"info","ts":"2026-05-26T05:39:11.308767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 56c01ea8fdc90390 elected leader 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-05-26T05:39:11.309775Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"56c01ea8fdc90390","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.132:2379]}","request-path":"/0/members/56c01ea8fdc90390/attributes","cluster-id":"c930fe821aab8609","publish-timeout":"7s"} {"level":"info","ts":"2026-05-26T05:39:11.309927Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T05:39:11.310014Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T05:39:11.310342Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:39:11.311593Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-26T05:39:11.311615Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-26T05:39:11.312707Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.132:2379"} {"level":"info","ts":"2026-05-26T05:39:11.31275Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-26T05:39:11.317641Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:39:11.31775Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:39:11.317779Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:39:14.109677Z","caller":"traceutil/trace.go:171","msg":"trace[1614339451] linearizableReadLoop","detail":"{readStateIndex:79; appliedIndex:78; }","duration":"441.383297ms","start":"2026-05-26T05:39:13.668261Z","end":"2026-05-26T05:39:14.109644Z","steps":["trace[1614339451] 'read index received' (duration: 441.127375ms)","trace[1614339451] 'applied index is now lower than readState.Index' (duration: 254.172µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:39:14.109806Z","caller":"traceutil/trace.go:171","msg":"trace[2111300353] transaction","detail":"{read_only:false; response_revision:75; number_of_response:1; }","duration":"443.305273ms","start":"2026-05-26T05:39:13.666443Z","end":"2026-05-26T05:39:14.109748Z","steps":["trace[2111300353] 'process raft request' (duration: 442.974651ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:14.110016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.688269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T05:39:14.110093Z","caller":"traceutil/trace.go:171","msg":"trace[441896959] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:75; }","duration":"441.85101ms","start":"2026-05-26T05:39:13.668225Z","end":"2026-05-26T05:39:14.110076Z","steps":["trace[441896959] 'agreement among raft nodes before linearized reading' (duration: 441.613989ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:14.110145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:13.668208Z","time spent":"441.927191ms","remote":"127.0.0.1:53176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:aggregate-to-admin\" "} {"level":"warn","ts":"2026-05-26T05:39:14.110135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.089611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-26T05:39:14.110181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.663926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T05:39:14.110261Z","caller":"traceutil/trace.go:171","msg":"trace[971446245] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:75; }","duration":"413.267692ms","start":"2026-05-26T05:39:13.696957Z","end":"2026-05-26T05:39:14.110225Z","steps":["trace[971446245] 'agreement among raft nodes before linearized reading' (duration: 413.029941ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:14.110315Z","caller":"traceutil/trace.go:171","msg":"trace[1607283661] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:75; }","duration":"345.847987ms","start":"2026-05-26T05:39:13.764431Z","end":"2026-05-26T05:39:14.110279Z","steps":["trace[1607283661] 'agreement among raft nodes before linearized reading' (duration: 345.576205ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:14.110325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:13.696944Z","time spent":"413.367714ms","remote":"127.0.0.1:52802","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-26T05:39:14.110375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:13.764417Z","time spent":"345.949227ms","remote":"127.0.0.1:52800","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-26T05:39:14.110993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:13.666418Z","time spent":"443.641525ms","remote":"127.0.0.1:53198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T05:39:14.617788Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256879325914917087,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-26T05:39:14.683599Z","caller":"traceutil/trace.go:171","msg":"trace[207801980] linearizableReadLoop","detail":"{readStateIndex:80; appliedIndex:79; }","duration":"566.172063ms","start":"2026-05-26T05:39:14.117386Z","end":"2026-05-26T05:39:14.683558Z","steps":["trace[207801980] 'read index received' (duration: 525.724694ms)","trace[207801980] 'applied index is now lower than readState.Index' (duration: 40.446189ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:39:14.683687Z","caller":"traceutil/trace.go:171","msg":"trace[122844837] transaction","detail":"{read_only:false; response_revision:76; number_of_response:1; }","duration":"566.690676ms","start":"2026-05-26T05:39:14.116934Z","end":"2026-05-26T05:39:14.683625Z","steps":["trace[122844837] 'process raft request' (duration: 526.308018ms)","trace[122844837] 'compare' (duration: 40.122056ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:39:14.6839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.485935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T05:39:14.683978Z","caller":"traceutil/trace.go:171","msg":"trace[1471061028] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:0; response_revision:76; }","duration":"566.628166ms","start":"2026-05-26T05:39:14.117332Z","end":"2026-05-26T05:39:14.68396Z","steps":["trace[1471061028] 'agreement among raft nodes before linearized reading' (duration: 566.429874ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:14.684017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:14.117311Z","time spent":"566.700327ms","remote":"127.0.0.1:53176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/edit\" "} {"level":"warn","ts":"2026-05-26T05:39:14.684003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.254357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-26T05:39:14.684098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:14.116917Z","time spent":"566.972748ms","remote":"127.0.0.1:53198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T05:39:14.684086Z","caller":"traceutil/trace.go:171","msg":"trace[209094566] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:76; }","duration":"255.425277ms","start":"2026-05-26T05:39:14.428641Z","end":"2026-05-26T05:39:14.684066Z","steps":["trace[209094566] 'agreement among raft nodes before linearized reading' (duration: 255.224336ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:15.013448Z","caller":"traceutil/trace.go:171","msg":"trace[203808966] linearizableReadLoop","detail":"{readStateIndex:81; appliedIndex:80; }","duration":"326.477109ms","start":"2026-05-26T05:39:14.686939Z","end":"2026-05-26T05:39:15.013416Z","steps":["trace[203808966] 'read index received' (duration: 326.259667ms)","trace[203808966] 'applied index is now lower than readState.Index' (duration: 216.452µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:39:15.013503Z","caller":"traceutil/trace.go:171","msg":"trace[1056610741] transaction","detail":"{read_only:false; response_revision:77; number_of_response:1; }","duration":"326.61262ms","start":"2026-05-26T05:39:14.686854Z","end":"2026-05-26T05:39:15.013467Z","steps":["trace[1056610741] 'process raft request' (duration: 326.416849ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:15.013649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:14.686826Z","time spent":"326.745432ms","remote":"127.0.0.1:52998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T05:39:15.013725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.280509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-26T05:39:15.01374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.438654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:430"} {"level":"info","ts":"2026-05-26T05:39:15.01379Z","caller":"traceutil/trace.go:171","msg":"trace[1162844712] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:77; }","duration":"249.39953ms","start":"2026-05-26T05:39:14.764375Z","end":"2026-05-26T05:39:15.013775Z","steps":["trace[1162844712] 'agreement among raft nodes before linearized reading' (duration: 249.203628ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:15.013798Z","caller":"traceutil/trace.go:171","msg":"trace[53025465] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:77; }","duration":"204.520605ms","start":"2026-05-26T05:39:14.809264Z","end":"2026-05-26T05:39:15.013785Z","steps":["trace[53025465] 'agreement among raft nodes before linearized reading' (duration: 204.390984ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:15.013844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.335806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-26T05:39:15.01388Z","caller":"traceutil/trace.go:171","msg":"trace[221655289] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:77; }","duration":"208.417386ms","start":"2026-05-26T05:39:14.80545Z","end":"2026-05-26T05:39:15.013867Z","steps":["trace[221655289] 'agreement among raft nodes before linearized reading' (duration: 208.333526ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:15.013747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.732822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T05:39:15.013971Z","caller":"traceutil/trace.go:171","msg":"trace[1684897457] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:0; response_revision:77; }","duration":"327.031804ms","start":"2026-05-26T05:39:14.686908Z","end":"2026-05-26T05:39:15.01394Z","steps":["trace[1684897457] 'agreement among raft nodes before linearized reading' (duration: 326.64261ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:15.014086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:14.686895Z","time spent":"327.152425ms","remote":"127.0.0.1:53176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:aggregate-to-view\" "} {"level":"info","ts":"2026-05-26T05:39:43.765885Z","caller":"traceutil/trace.go:171","msg":"trace[5415641] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"149.923505ms","start":"2026-05-26T05:39:43.615564Z","end":"2026-05-26T05:39:43.765487Z","steps":["trace[5415641] 'process raft request' (duration: 149.75115ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:46.889916Z","caller":"traceutil/trace.go:171","msg":"trace[162899714] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"130.504176ms","start":"2026-05-26T05:39:46.75938Z","end":"2026-05-26T05:39:46.889884Z","steps":["trace[162899714] 'process raft request' (duration: 130.328891ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:46.897818Z","caller":"traceutil/trace.go:171","msg":"trace[1891293963] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"128.426754ms","start":"2026-05-26T05:39:46.769374Z","end":"2026-05-26T05:39:46.897801Z","steps":["trace[1891293963] 'process raft request' (duration: 127.97733ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:46.897905Z","caller":"traceutil/trace.go:171","msg":"trace[433845118] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"128.490386ms","start":"2026-05-26T05:39:46.769409Z","end":"2026-05-26T05:39:46.8979Z","steps":["trace[433845118] 'process raft request' (duration: 128.001361ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:46.898056Z","caller":"traceutil/trace.go:171","msg":"trace[1612601983] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"115.374195ms","start":"2026-05-26T05:39:46.782674Z","end":"2026-05-26T05:39:46.898049Z","steps":["trace[1612601983] 'process raft request' (duration: 114.908211ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:46.89817Z","caller":"traceutil/trace.go:171","msg":"trace[182496776] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"104.537395ms","start":"2026-05-26T05:39:46.793597Z","end":"2026-05-26T05:39:46.898135Z","steps":["trace[182496776] 'process raft request' (duration: 104.021979ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:46.898277Z","caller":"traceutil/trace.go:171","msg":"trace[1955416866] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"126.35731ms","start":"2026-05-26T05:39:46.771891Z","end":"2026-05-26T05:39:46.898248Z","steps":["trace[1955416866] 'process raft request' (duration: 125.598287ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:46.898365Z","caller":"traceutil/trace.go:171","msg":"trace[1674035384] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"126.484784ms","start":"2026-05-26T05:39:46.771856Z","end":"2026-05-26T05:39:46.898341Z","steps":["trace[1674035384] 'process raft request' (duration: 125.576537ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:46.898317Z","caller":"traceutil/trace.go:171","msg":"trace[1787173329] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"121.214303ms","start":"2026-05-26T05:39:46.777052Z","end":"2026-05-26T05:39:46.898266Z","steps":["trace[1787173329] 'process raft request' (duration: 120.497971ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:46.898308Z","caller":"traceutil/trace.go:171","msg":"trace[409447930] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"122.255825ms","start":"2026-05-26T05:39:46.775958Z","end":"2026-05-26T05:39:46.898213Z","steps":["trace[409447930] 'process raft request' (duration: 121.571695ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:46.898875Z","caller":"traceutil/trace.go:171","msg":"trace[1830841138] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"125.104193ms","start":"2026-05-26T05:39:46.773748Z","end":"2026-05-26T05:39:46.898852Z","steps":["trace[1830841138] 'process raft request' (duration: 123.760122ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:47.238613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.901775ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:39:47.238698Z","caller":"traceutil/trace.go:171","msg":"trace[55287215] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"327.801371ms","start":"2026-05-26T05:39:46.910882Z","end":"2026-05-26T05:39:47.238684Z","steps":["trace[55287215] 'process raft request' (duration: 121.677629ms)","trace[55287215] 'compare' (duration: 205.781632ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:39:47.238735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:46.910874Z","time spent":"327.846512ms","remote":"127.0.0.1:53338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T05:39:47.241679Z","caller":"traceutil/trace.go:171","msg":"trace[739507154] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"320.074855ms","start":"2026-05-26T05:39:46.921591Z","end":"2026-05-26T05:39:47.241666Z","steps":["trace[739507154] 'process raft request' (duration: 319.94486ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:47.241935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:46.921575Z","time spent":"320.147717ms","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:39:47.242088Z","caller":"traceutil/trace.go:171","msg":"trace[809843118] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"316.997211ms","start":"2026-05-26T05:39:46.925073Z","end":"2026-05-26T05:39:47.24207Z","steps":["trace[809843118] 'process raft request' (duration: 316.722753ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:47.24215Z","caller":"traceutil/trace.go:171","msg":"trace[430276776] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"316.145905ms","start":"2026-05-26T05:39:46.925993Z","end":"2026-05-26T05:39:47.242139Z","steps":["trace[430276776] 'process raft request' (duration: 315.97757ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:47.242171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:46.925053Z","time spent":"317.079153ms","remote":"127.0.0.1:53338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T05:39:47.242208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:46.925937Z","time spent":"316.238848ms","remote":"127.0.0.1:53338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T05:39:47.242253Z","caller":"traceutil/trace.go:171","msg":"trace[1666604104] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"315.691591ms","start":"2026-05-26T05:39:46.926545Z","end":"2026-05-26T05:39:47.242237Z","steps":["trace[1666604104] 'process raft request' (duration: 315.533727ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:47.242327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:46.926487Z","time spent":"315.800684ms","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T05:39:47.242393Z","caller":"traceutil/trace.go:171","msg":"trace[511621409] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"314.149193ms","start":"2026-05-26T05:39:46.928238Z","end":"2026-05-26T05:39:47.242387Z","steps":["trace[511621409] 'process raft request' (duration: 313.906046ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:47.242436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:46.928218Z","time spent":"314.189244ms","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:39:47.242443Z","caller":"traceutil/trace.go:171","msg":"trace[973426035] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"308.039977ms","start":"2026-05-26T05:39:46.934391Z","end":"2026-05-26T05:39:47.242431Z","steps":["trace[973426035] 'process raft request' (duration: 307.895033ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:47.242452Z","caller":"traceutil/trace.go:171","msg":"trace[1613627520] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"313.760111ms","start":"2026-05-26T05:39:46.928681Z","end":"2026-05-26T05:39:47.242441Z","steps":["trace[1613627520] 'process raft request' (duration: 313.547765ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:47.242461Z","caller":"traceutil/trace.go:171","msg":"trace[274641507] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"305.540511ms","start":"2026-05-26T05:39:46.936907Z","end":"2026-05-26T05:39:47.242448Z","steps":["trace[274641507] 'process raft request' (duration: 305.444058ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:47.242494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:46.934385Z","time spent":"308.079098ms","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:39:47.242514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:46.928675Z","time spent":"313.804404ms","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:39:47.242605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:46.936889Z","time spent":"305.624064ms","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:39:47.241892Z","caller":"traceutil/trace.go:171","msg":"trace[433638849] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"320.22258ms","start":"2026-05-26T05:39:46.921647Z","end":"2026-05-26T05:39:47.241869Z","steps":["trace[433638849] 'process raft request' (duration: 319.983313ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:47.243131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:46.921642Z","time spent":"321.438456ms","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:39:51.235273Z","caller":"traceutil/trace.go:171","msg":"trace[788978288] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"102.819396ms","start":"2026-05-26T05:39:51.132439Z","end":"2026-05-26T05:39:51.235259Z","steps":["trace[788978288] 'process raft request' (duration: 101.691554ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:53.463979Z","caller":"traceutil/trace.go:171","msg":"trace[1132287255] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"145.679392ms","start":"2026-05-26T05:39:53.318273Z","end":"2026-05-26T05:39:53.463953Z","steps":["trace[1132287255] 'read index received' (duration: 144.91033ms)","trace[1132287255] 'applied index is now lower than readState.Index' (duration: 768.112µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:39:53.464128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.843717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-26T05:39:53.464285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.480927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-26T05:39:53.464294Z","caller":"traceutil/trace.go:171","msg":"trace[1797272626] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:586; }","duration":"146.054243ms","start":"2026-05-26T05:39:53.318223Z","end":"2026-05-26T05:39:53.464277Z","steps":["trace[1797272626] 'agreement among raft nodes before linearized reading' (duration: 145.826726ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:53.464289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.596771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-05-26T05:39:53.4643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.612506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-lr4rw\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-26T05:39:53.46435Z","caller":"traceutil/trace.go:171","msg":"trace[1932908617] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:586; }","duration":"145.578449ms","start":"2026-05-26T05:39:53.318752Z","end":"2026-05-26T05:39:53.46433Z","steps":["trace[1932908617] 'agreement among raft nodes before linearized reading' (duration: 145.366903ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:53.464354Z","caller":"traceutil/trace.go:171","msg":"trace[262575498] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:586; }","duration":"144.715564ms","start":"2026-05-26T05:39:53.319623Z","end":"2026-05-26T05:39:53.464338Z","steps":["trace[262575498] 'agreement among raft nodes before linearized reading' (duration: 144.526119ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:53.464386Z","caller":"traceutil/trace.go:171","msg":"trace[376433356] range","detail":"{range_begin:/registry/pods/kube-system/cilium-lr4rw; range_end:; response_count:1; response_revision:586; }","duration":"125.724879ms","start":"2026-05-26T05:39:53.338638Z","end":"2026-05-26T05:39:53.464363Z","steps":["trace[376433356] 'agreement among raft nodes before linearized reading' (duration: 125.486512ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:53.464014Z","caller":"traceutil/trace.go:171","msg":"trace[1370082807] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"297.212131ms","start":"2026-05-26T05:39:53.166768Z","end":"2026-05-26T05:39:53.463981Z","steps":["trace[1370082807] 'process raft request' (duration: 296.673135ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:53.633371Z","caller":"traceutil/trace.go:171","msg":"trace[1141245531] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"164.114244ms","start":"2026-05-26T05:39:53.46923Z","end":"2026-05-26T05:39:53.633344Z","steps":["trace[1141245531] 'process raft request' (duration: 93.034577ms)","trace[1141245531] 'compare' (duration: 70.927302ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:39:53.633711Z","caller":"traceutil/trace.go:171","msg":"trace[675304586] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"164.268818ms","start":"2026-05-26T05:39:53.46942Z","end":"2026-05-26T05:39:53.633689Z","steps":["trace[675304586] 'process raft request' (duration: 163.895508ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:53.633779Z","caller":"traceutil/trace.go:171","msg":"trace[731106125] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"155.16217ms","start":"2026-05-26T05:39:53.478603Z","end":"2026-05-26T05:39:53.633765Z","steps":["trace[731106125] 'process raft request' (duration: 154.970035ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:53.63386Z","caller":"traceutil/trace.go:171","msg":"trace[981938321] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"116.866ms","start":"2026-05-26T05:39:53.516988Z","end":"2026-05-26T05:39:53.633854Z","steps":["trace[981938321] 'process raft request' (duration: 116.676744ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:55.810659Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.781162426s","expected-duration":"1s"} {"level":"info","ts":"2026-05-26T05:39:55.811279Z","caller":"traceutil/trace.go:171","msg":"trace[1820339707] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"1.781877365s","start":"2026-05-26T05:39:54.029377Z","end":"2026-05-26T05:39:55.811254Z","steps":["trace[1820339707] 'process raft request' (duration: 1.78169209s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:55.811485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:54.029351Z","time spent":"1.782005158s","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:39:55.940508Z","caller":"traceutil/trace.go:171","msg":"trace[2077756479] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:614; }","duration":"448.695417ms","start":"2026-05-26T05:39:55.491769Z","end":"2026-05-26T05:39:55.940464Z","steps":["trace[2077756479] 'read index received' (duration: 319.379175ms)","trace[2077756479] 'applied index is now lower than readState.Index' (duration: 129.315262ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:39:55.940536Z","caller":"traceutil/trace.go:171","msg":"trace[1979720746] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"1.902526575s","start":"2026-05-26T05:39:54.037988Z","end":"2026-05-26T05:39:55.940515Z","steps":["trace[1979720746] 'process raft request' (duration: 1.894956836s)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:55.940577Z","caller":"traceutil/trace.go:171","msg":"trace[778811421] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"1.780504277s","start":"2026-05-26T05:39:54.16004Z","end":"2026-05-26T05:39:55.940544Z","steps":["trace[778811421] 'process raft request' (duration: 1.780369393s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:55.940646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:54.037969Z","time spent":"1.902620827s","remote":"127.0.0.1:52910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:39:55.940712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.22767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T05:39:55.940714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:54.160026Z","time spent":"1.78060995s","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:39:55.940747Z","caller":"traceutil/trace.go:171","msg":"trace[644730012] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"231.278821ms","start":"2026-05-26T05:39:55.709457Z","end":"2026-05-26T05:39:55.940736Z","steps":["trace[644730012] 'agreement among raft nodes before linearized reading' (duration: 231.236249ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:55.940658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.892562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-26T05:39:55.940856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.309755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.132\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-26T05:39:55.940882Z","caller":"traceutil/trace.go:171","msg":"trace[2133429270] range","detail":"{range_begin:/registry/masterleases/199.204.45.132; range_end:; response_count:1; response_revision:594; }","duration":"175.372926ms","start":"2026-05-26T05:39:55.765499Z","end":"2026-05-26T05:39:55.940872Z","steps":["trace[2133429270] 'agreement among raft nodes before linearized reading' (duration: 175.304685ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:39:55.940877Z","caller":"traceutil/trace.go:171","msg":"trace[946770549] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:594; }","duration":"449.14311ms","start":"2026-05-26T05:39:55.491723Z","end":"2026-05-26T05:39:55.940866Z","steps":["trace[946770549] 'agreement among raft nodes before linearized reading' (duration: 448.871782ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:55.940986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:55.49166Z","time spent":"449.316955ms","remote":"127.0.0.1:53088","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":"warn","ts":"2026-05-26T05:39:55.940894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.335374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-26T05:39:55.941076Z","caller":"traceutil/trace.go:171","msg":"trace[533383150] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:594; }","duration":"302.557719ms","start":"2026-05-26T05:39:55.638503Z","end":"2026-05-26T05:39:55.941061Z","steps":["trace[533383150] 'agreement among raft nodes before linearized reading' (duration: 302.22196ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:55.941134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:55.638478Z","time spent":"302.630422ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T05:39:55.94246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.905907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-26T05:39:55.942589Z","caller":"traceutil/trace.go:171","msg":"trace[1625484811] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:594; }","duration":"304.056161ms","start":"2026-05-26T05:39:55.638475Z","end":"2026-05-26T05:39:55.942531Z","steps":["trace[1625484811] 'agreement among raft nodes before linearized reading' (duration: 302.224621ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:39:55.942661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:39:55.638457Z","time spent":"304.177545ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-26T05:39:57.784326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.186346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:39:57.784414Z","caller":"traceutil/trace.go:171","msg":"trace[1404429834] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:634; }","duration":"152.291809ms","start":"2026-05-26T05:39:57.632101Z","end":"2026-05-26T05:39:57.784393Z","steps":["trace[1404429834] 'range keys from in-memory index tree' (duration: 152.094314ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:40:00.767249Z","caller":"traceutil/trace.go:171","msg":"trace[1539482419] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"105.315732ms","start":"2026-05-26T05:40:00.661888Z","end":"2026-05-26T05:40:00.767203Z","steps":["trace[1539482419] 'process raft request' (duration: 105.050774ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:40:05.478859Z","caller":"traceutil/trace.go:171","msg":"trace[935870924] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"112.069762ms","start":"2026-05-26T05:40:05.366769Z","end":"2026-05-26T05:40:05.478838Z","steps":["trace[935870924] 'process raft request' (duration: 111.893928ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:40:05.691598Z","caller":"traceutil/trace.go:171","msg":"trace[1223503141] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"167.285827ms","start":"2026-05-26T05:40:05.524281Z","end":"2026-05-26T05:40:05.691567Z","steps":["trace[1223503141] 'process raft request' (duration: 140.641494ms)","trace[1223503141] 'compare' (duration: 26.306534ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:40:05.691619Z","caller":"traceutil/trace.go:171","msg":"trace[465962751] transaction","detail":"{read_only:false; response_revision:716; number_of_response:1; }","duration":"161.626777ms","start":"2026-05-26T05:40:05.529968Z","end":"2026-05-26T05:40:05.691595Z","steps":["trace[465962751] 'process raft request' (duration: 161.506974ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:40:05.715578Z","caller":"traceutil/trace.go:171","msg":"trace[796666096] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"137.036584ms","start":"2026-05-26T05:40:05.57853Z","end":"2026-05-26T05:40:05.715567Z","steps":["trace[796666096] 'process raft request' (duration: 136.939212ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:40:11.941171Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256879325914918508,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T05:40:12.31133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.020413604s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-26T05:40:12.311443Z","caller":"traceutil/trace.go:171","msg":"trace[316619178] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:754; }","duration":"1.020574448s","start":"2026-05-26T05:40:11.29085Z","end":"2026-05-26T05:40:12.311424Z","steps":["trace[316619178] 'range keys from in-memory index tree' (duration: 1.020195138s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:40:12.31149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:40:11.290833Z","time spent":"1.020647499s","remote":"127.0.0.1:53088","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-26T05:40:12.31268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.816691ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-26T05:40:12.312908Z","caller":"traceutil/trace.go:171","msg":"trace[1845165952] linearizableReadLoop","detail":"{readStateIndex:784; appliedIndex:783; }","duration":"872.83078ms","start":"2026-05-26T05:40:11.440061Z","end":"2026-05-26T05:40:12.312891Z","steps":["trace[1845165952] 'read index received' (duration: 581.747513ms)","trace[1845165952] 'applied index is now lower than readState.Index' (duration: 291.081637ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:40:12.313036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.315969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:40:12.313064Z","caller":"traceutil/trace.go:171","msg":"trace[818985122] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:754; }","duration":"602.388431ms","start":"2026-05-26T05:40:11.710667Z","end":"2026-05-26T05:40:12.313056Z","steps":["trace[818985122] 'agreement among raft nodes before linearized reading' (duration: 602.331419ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:40:12.313099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:40:11.710646Z","time spent":"602.446721ms","remote":"127.0.0.1:52802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-26T05:40:12.313359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.826714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-05-26T05:40:12.313397Z","caller":"traceutil/trace.go:171","msg":"trace[1806944364] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:754; }","duration":"165.908846ms","start":"2026-05-26T05:40:12.147479Z","end":"2026-05-26T05:40:12.313388Z","steps":["trace[1806944364] 'agreement among raft nodes before linearized reading' (duration: 165.803964ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:40:12.313224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"873.141507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-mckdv\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-26T05:40:12.313515Z","caller":"traceutil/trace.go:171","msg":"trace[806876860] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-mckdv; range_end:; response_count:1; response_revision:754; }","duration":"873.458024ms","start":"2026-05-26T05:40:11.440015Z","end":"2026-05-26T05:40:12.313473Z","steps":["trace[806876860] 'agreement among raft nodes before linearized reading' (duration: 872.937792ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:40:12.313572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.146152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-05-26T05:40:12.313596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:40:11.439995Z","time spent":"873.560196ms","remote":"127.0.0.1:52998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-mckdv\" "} {"level":"info","ts":"2026-05-26T05:40:12.313609Z","caller":"traceutil/trace.go:171","msg":"trace[543233736] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:754; }","duration":"166.211504ms","start":"2026-05-26T05:40:12.147386Z","end":"2026-05-26T05:40:12.313597Z","steps":["trace[543233736] 'agreement among raft nodes before linearized reading' (duration: 166.129172ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:40:12.313803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.919314ms","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-26T05:40:12.313883Z","caller":"traceutil/trace.go:171","msg":"trace[443060897] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:754; }","duration":"419.064677ms","start":"2026-05-26T05:40:11.894801Z","end":"2026-05-26T05:40:12.313865Z","steps":["trace[443060897] 'agreement among raft nodes before linearized reading' (duration: 418.830522ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:40:12.31393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:40:11.894769Z","time spent":"419.153359ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T05:40:12.314034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.01117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-26T05:40:12.314125Z","caller":"traceutil/trace.go:171","msg":"trace[690257113] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:754; }","duration":"243.194083ms","start":"2026-05-26T05:40:12.070918Z","end":"2026-05-26T05:40:12.314112Z","steps":["trace[690257113] 'agreement among raft nodes before linearized reading' (duration: 242.785873ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:40:40.121187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.458878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:40:40.121296Z","caller":"traceutil/trace.go:171","msg":"trace[264600272] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1153; }","duration":"279.646341ms","start":"2026-05-26T05:40:39.84163Z","end":"2026-05-26T05:40:40.121276Z","steps":["trace[264600272] 'count revisions from in-memory index tree' (duration: 279.331985ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:40:40.694361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.366479ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:40:40.694521Z","caller":"traceutil/trace.go:171","msg":"trace[2139974938] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"189.735154ms","start":"2026-05-26T05:40:40.504757Z","end":"2026-05-26T05:40:40.694492Z","steps":["trace[2139974938] 'process raft request' (duration: 33.108711ms)","trace[2139974938] 'compare' (duration: 156.245637ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:40:40.806931Z","caller":"traceutil/trace.go:171","msg":"trace[1086416901] transaction","detail":"{read_only:false; response_revision:1157; number_of_response:1; }","duration":"301.948722ms","start":"2026-05-26T05:40:40.504954Z","end":"2026-05-26T05:40:40.806903Z","steps":["trace[1086416901] 'process raft request' (duration: 300.339782ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:40:40.807198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:40:40.504931Z","time spent":"302.149375ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:40:40.807202Z","caller":"traceutil/trace.go:171","msg":"trace[654088146] transaction","detail":"{read_only:false; response_revision:1158; number_of_response:1; }","duration":"301.807339ms","start":"2026-05-26T05:40:40.505363Z","end":"2026-05-26T05:40:40.807171Z","steps":["trace[654088146] 'process raft request' (duration: 301.492374ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:40:40.80751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:40:40.505354Z","time spent":"302.050183ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:40:40.807535Z","caller":"traceutil/trace.go:171","msg":"trace[286934472] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"110.19027ms","start":"2026-05-26T05:40:40.697323Z","end":"2026-05-26T05:40:40.807513Z","steps":["trace[286934472] 'process raft request' (duration: 109.756513ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:40:42.615035Z","caller":"traceutil/trace.go:171","msg":"trace[950402432] transaction","detail":"{read_only:false; response_revision:1160; number_of_response:1; }","duration":"109.69167ms","start":"2026-05-26T05:40:42.505321Z","end":"2026-05-26T05:40:42.615012Z","steps":["trace[950402432] 'process raft request' (duration: 109.540957ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:40:42.620632Z","caller":"traceutil/trace.go:171","msg":"trace[1908545477] transaction","detail":"{read_only:false; response_revision:1161; number_of_response:1; }","duration":"113.169493ms","start":"2026-05-26T05:40:42.507438Z","end":"2026-05-26T05:40:42.620607Z","steps":["trace[1908545477] 'process raft request' (duration: 111.477723ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:40:57.633823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.156016ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:40:57.634226Z","caller":"traceutil/trace.go:171","msg":"trace[341352948] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"227.712842ms","start":"2026-05-26T05:40:57.406489Z","end":"2026-05-26T05:40:57.634202Z","steps":["trace[341352948] 'process raft request' (duration: 83.104249ms)","trace[341352948] 'compare' (duration: 144.020084ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:40:57.649926Z","caller":"traceutil/trace.go:171","msg":"trace[827174499] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"242.780083ms","start":"2026-05-26T05:40:57.407125Z","end":"2026-05-26T05:40:57.649905Z","steps":["trace[827174499] 'process raft request' (duration: 242.513019ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:40:57.64992Z","caller":"traceutil/trace.go:171","msg":"trace[1556240204] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"209.145695ms","start":"2026-05-26T05:40:57.440746Z","end":"2026-05-26T05:40:57.649892Z","steps":["trace[1556240204] 'process raft request' (duration: 209.068744ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:40:57.656359Z","caller":"traceutil/trace.go:171","msg":"trace[1421645902] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"116.463162ms","start":"2026-05-26T05:40:57.539875Z","end":"2026-05-26T05:40:57.656338Z","steps":["trace[1421645902] 'process raft request' (duration: 115.972704ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:40:58.189762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.572503ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:40:58.18997Z","caller":"traceutil/trace.go:171","msg":"trace[322836701] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"481.231907ms","start":"2026-05-26T05:40:57.708684Z","end":"2026-05-26T05:40:58.189916Z","steps":["trace[322836701] 'process raft request' (duration: 330.391041ms)","trace[322836701] 'compare' (duration: 150.226096ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:40:58.190186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:40:57.708662Z","time spent":"481.400069ms","remote":"127.0.0.1:52910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105279,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:40:58.356376Z","caller":"traceutil/trace.go:171","msg":"trace[1319765177] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"151.265853ms","start":"2026-05-26T05:40:58.205074Z","end":"2026-05-26T05:40:58.35634Z","steps":["trace[1319765177] 'process raft request' (duration: 94.411619ms)","trace[1319765177] 'compare' (duration: 56.642311ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:41:09.147954Z","caller":"traceutil/trace.go:171","msg":"trace[537510925] transaction","detail":"{read_only:false; response_revision:1432; number_of_response:1; }","duration":"364.764083ms","start":"2026-05-26T05:41:08.783155Z","end":"2026-05-26T05:41:09.147919Z","steps":["trace[537510925] 'process raft request' (duration: 364.55399ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:09.147958Z","caller":"traceutil/trace.go:171","msg":"trace[1267056840] linearizableReadLoop","detail":"{readStateIndex:1481; appliedIndex:1481; }","duration":"359.497405ms","start":"2026-05-26T05:41:08.788417Z","end":"2026-05-26T05:41:09.147915Z","steps":["trace[1267056840] 'read index received' (duration: 359.477214ms)","trace[1267056840] 'applied index is now lower than readState.Index' (duration: 16.991µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:41:09.148171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:08.783129Z","time spent":"364.935016ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:41:09.148202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.787189ms","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-26T05:41:09.148259Z","caller":"traceutil/trace.go:171","msg":"trace[1817492232] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1432; }","duration":"359.904001ms","start":"2026-05-26T05:41:08.788342Z","end":"2026-05-26T05:41:09.148246Z","steps":["trace[1817492232] 'agreement among raft nodes before linearized reading' (duration: 359.719568ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:09.148294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:08.788311Z","time spent":"359.975622ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-26T05:41:09.273427Z","caller":"traceutil/trace.go:171","msg":"trace[606107352] linearizableReadLoop","detail":"{readStateIndex:1482; appliedIndex:1481; }","duration":"125.215231ms","start":"2026-05-26T05:41:09.148172Z","end":"2026-05-26T05:41:09.273388Z","steps":["trace[606107352] 'read index received' (duration: 91.189459ms)","trace[606107352] 'applied index is now lower than readState.Index' (duration: 34.024662ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:41:09.273641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.465788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"warn","ts":"2026-05-26T05:41:09.273704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.560579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-26T05:41:09.273746Z","caller":"traceutil/trace.go:171","msg":"trace[2075993131] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1433; }","duration":"249.59687ms","start":"2026-05-26T05:41:09.024124Z","end":"2026-05-26T05:41:09.273721Z","steps":["trace[2075993131] 'agreement among raft nodes before linearized reading' (duration: 249.331996ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:09.273641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.721729ms","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-26T05:41:09.273789Z","caller":"traceutil/trace.go:171","msg":"trace[390278328] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1433; }","duration":"249.692921ms","start":"2026-05-26T05:41:09.024074Z","end":"2026-05-26T05:41:09.273767Z","steps":["trace[390278328] 'agreement among raft nodes before linearized reading' (duration: 249.420468ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:09.273814Z","caller":"traceutil/trace.go:171","msg":"trace[1376873138] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1433; }","duration":"345.969042ms","start":"2026-05-26T05:41:08.927832Z","end":"2026-05-26T05:41:09.273801Z","steps":["trace[1376873138] 'agreement among raft nodes before linearized reading' (duration: 345.683518ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:09.273846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:08.927791Z","time spent":"346.045373ms","remote":"127.0.0.1:53088","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-26T05:41:09.273985Z","caller":"traceutil/trace.go:171","msg":"trace[1372877172] transaction","detail":"{read_only:false; response_revision:1433; number_of_response:1; }","duration":"283.549655ms","start":"2026-05-26T05:41:08.989872Z","end":"2026-05-26T05:41:09.273422Z","steps":["trace[1372877172] 'process raft request' (duration: 249.453591ms)","trace[1372877172] 'compare' (duration: 33.918081ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:41:09.299934Z","caller":"traceutil/trace.go:171","msg":"trace[971935034] transaction","detail":"{read_only:false; response_revision:1434; number_of_response:1; }","duration":"147.635073ms","start":"2026-05-26T05:41:09.152274Z","end":"2026-05-26T05:41:09.299909Z","steps":["trace[971935034] 'process raft request' (duration: 147.517822ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:21.300634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.605758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/perconaxtradbclusters.pxc.percona.com\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T05:41:21.300726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.58086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-26T05:41:21.300779Z","caller":"traceutil/trace.go:171","msg":"trace[1372971487] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/perconaxtradbclusters.pxc.percona.com; range_end:; response_count:0; response_revision:1665; }","duration":"127.799491ms","start":"2026-05-26T05:41:21.172942Z","end":"2026-05-26T05:41:21.300742Z","steps":["trace[1372971487] 'range keys from in-memory index tree' (duration: 127.502177ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:21.300868Z","caller":"traceutil/trace.go:171","msg":"trace[2081922202] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1665; }","duration":"101.702821ms","start":"2026-05-26T05:41:21.199089Z","end":"2026-05-26T05:41:21.300792Z","steps":["trace[2081922202] 'range keys from in-memory index tree' (duration: 101.413117ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:23.419445Z","caller":"traceutil/trace.go:171","msg":"trace[304377363] transaction","detail":"{read_only:false; response_revision:1686; number_of_response:1; }","duration":"105.016121ms","start":"2026-05-26T05:41:23.314407Z","end":"2026-05-26T05:41:23.419423Z","steps":["trace[304377363] 'process raft request' (duration: 104.89928ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:35.936334Z","caller":"traceutil/trace.go:171","msg":"trace[380510438] linearizableReadLoop","detail":"{readStateIndex:1934; appliedIndex:1933; }","duration":"452.282962ms","start":"2026-05-26T05:41:35.484026Z","end":"2026-05-26T05:41:35.936308Z","steps":["trace[380510438] 'read index received' (duration: 452.14797ms)","trace[380510438] 'applied index is now lower than readState.Index' (duration: 133.932µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:41:35.936477Z","caller":"traceutil/trace.go:171","msg":"trace[115572781] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"456.376945ms","start":"2026-05-26T05:41:35.480058Z","end":"2026-05-26T05:41:35.936435Z","steps":["trace[115572781] 'process raft request' (duration: 456.103832ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:35.936665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.201495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T05:41:35.936682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:35.480035Z","time spent":"456.542497ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:41:35.936742Z","caller":"traceutil/trace.go:171","msg":"trace[310464461] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1857; }","duration":"227.329496ms","start":"2026-05-26T05:41:35.709393Z","end":"2026-05-26T05:41:35.936722Z","steps":["trace[310464461] 'agreement among raft nodes before linearized reading' (duration: 227.219784ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:35.936741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.790437ms","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-26T05:41:35.936805Z","caller":"traceutil/trace.go:171","msg":"trace[431974000] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1857; }","duration":"448.877859ms","start":"2026-05-26T05:41:35.48791Z","end":"2026-05-26T05:41:35.936788Z","steps":["trace[431974000] 'agreement among raft nodes before linearized reading' (duration: 448.705255ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:35.93686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:35.487898Z","time spent":"448.94912ms","remote":"127.0.0.1:53088","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":"warn","ts":"2026-05-26T05:41:35.936889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.526045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-26T05:41:35.936981Z","caller":"traceutil/trace.go:171","msg":"trace[1964324027] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1857; }","duration":"441.648767ms","start":"2026-05-26T05:41:35.495308Z","end":"2026-05-26T05:41:35.936956Z","steps":["trace[1964324027] 'agreement among raft nodes before linearized reading' (duration: 441.384542ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:35.93703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:35.495297Z","time spent":"441.724877ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-26T05:41:35.937044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.251561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-05-26T05:41:35.937238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.708278ms","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-26T05:41:35.937396Z","caller":"traceutil/trace.go:171","msg":"trace[2091807693] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1857; }","duration":"445.901251ms","start":"2026-05-26T05:41:35.491474Z","end":"2026-05-26T05:41:35.937375Z","steps":["trace[2091807693] 'agreement among raft nodes before linearized reading' (duration: 445.226311ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:35.937509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:35.491453Z","time spent":"446.037393ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T05:41:35.937045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.918123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.132\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-05-26T05:41:35.937323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.586105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-26T05:41:35.938071Z","caller":"traceutil/trace.go:171","msg":"trace[1457588059] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1857; }","duration":"453.863342ms","start":"2026-05-26T05:41:35.48398Z","end":"2026-05-26T05:41:35.937844Z","steps":["trace[1457588059] 'agreement among raft nodes before linearized reading' (duration: 452.484315ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:35.938187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:35.483958Z","time spent":"454.186567ms","remote":"127.0.0.1:53088","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-26T05:41:35.937104Z","caller":"traceutil/trace.go:171","msg":"trace[43954783] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1857; }","duration":"441.333842ms","start":"2026-05-26T05:41:35.495755Z","end":"2026-05-26T05:41:35.937089Z","steps":["trace[43954783] 'agreement among raft nodes before linearized reading' (duration: 441.208541ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:35.938537Z","caller":"traceutil/trace.go:171","msg":"trace[2044707503] range","detail":"{range_begin:/registry/masterleases/199.204.45.132; range_end:; response_count:1; response_revision:1857; }","duration":"168.407361ms","start":"2026-05-26T05:41:35.770111Z","end":"2026-05-26T05:41:35.938518Z","steps":["trace[2044707503] 'agreement among raft nodes before linearized reading' (duration: 166.835561ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:35.938584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:35.49574Z","time spent":"442.826431ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-26T05:41:36.37151Z","caller":"traceutil/trace.go:171","msg":"trace[1285097171] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"428.617266ms","start":"2026-05-26T05:41:35.942858Z","end":"2026-05-26T05:41:36.371475Z","steps":["trace[1285097171] 'process raft request' (duration: 428.418323ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:36.371555Z","caller":"traceutil/trace.go:171","msg":"trace[906728035] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"428.606636ms","start":"2026-05-26T05:41:35.942901Z","end":"2026-05-26T05:41:36.371508Z","steps":["trace[906728035] 'process raft request' (duration: 428.508665ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:36.372142Z","caller":"traceutil/trace.go:171","msg":"trace[918736439] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"428.049348ms","start":"2026-05-26T05:41:35.944081Z","end":"2026-05-26T05:41:36.372131Z","steps":["trace[918736439] 'process raft request' (duration: 428.010787ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:36.372189Z","caller":"traceutil/trace.go:171","msg":"trace[295313814] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"428.407992ms","start":"2026-05-26T05:41:35.943756Z","end":"2026-05-26T05:41:36.372164Z","steps":["trace[295313814] 'process raft request' (duration: 427.894706ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:36.372313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:35.944074Z","time spent":"428.108058ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:41:36.372415Z","caller":"traceutil/trace.go:171","msg":"trace[641759125] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"428.380193ms","start":"2026-05-26T05:41:35.944001Z","end":"2026-05-26T05:41:36.372381Z","steps":["trace[641759125] 'process raft request' (duration: 428.050948ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:36.372511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:35.943985Z","time spent":"428.478384ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:41:36.371713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:35.942835Z","time spent":"428.760197ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:41:36.371826Z","caller":"traceutil/trace.go:171","msg":"trace[590266442] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"428.744877ms","start":"2026-05-26T05:41:35.94304Z","end":"2026-05-26T05:41:36.371784Z","steps":["trace[590266442] 'process raft request' (duration: 428.411053ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:36.372861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:35.943749Z","time spent":"428.493464ms","remote":"127.0.0.1:52998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:41:36.372887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:35.943026Z","time spent":"429.776201ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:41:36.373031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:35.94288Z","time spent":"429.019811ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:41:36.583403Z","caller":"traceutil/trace.go:171","msg":"trace[350743688] linearizableReadLoop","detail":"{readStateIndex:1942; appliedIndex:1935; }","duration":"539.335396ms","start":"2026-05-26T05:41:36.044039Z","end":"2026-05-26T05:41:36.583375Z","steps":["trace[350743688] 'read index received' (duration: 327.260109ms)","trace[350743688] 'applied index is now lower than readState.Index' (duration: 212.073477ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:41:36.583536Z","caller":"traceutil/trace.go:171","msg":"trace[1965684157] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"630.433301ms","start":"2026-05-26T05:41:35.953076Z","end":"2026-05-26T05:41:36.583509Z","steps":["trace[1965684157] 'process raft request' (duration: 580.064349ms)","trace[1965684157] 'compare' (duration: 49.869616ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:41:36.58379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:35.953065Z","time spent":"630.562434ms","remote":"127.0.0.1:52832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:41:36.584299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.255818ms","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-26T05:41:36.584412Z","caller":"traceutil/trace.go:171","msg":"trace[203646313] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1864; }","duration":"540.341398ms","start":"2026-05-26T05:41:36.044002Z","end":"2026-05-26T05:41:36.584343Z","steps":["trace[203646313] 'agreement among raft nodes before linearized reading' (duration: 539.526758ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:36.584538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:36.043989Z","time spent":"540.50046ms","remote":"127.0.0.1:60864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-26T05:41:36.586318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.301423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:41:36.586424Z","caller":"traceutil/trace.go:171","msg":"trace[433691780] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1865; }","duration":"419.411044ms","start":"2026-05-26T05:41:36.166981Z","end":"2026-05-26T05:41:36.586392Z","steps":["trace[433691780] 'agreement among raft nodes before linearized reading' (duration: 419.249832ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:36.58651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:36.166918Z","time spent":"419.572187ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-05-26T05:41:36.586637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.617033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d4c96f2d-c61d-4390-b835-5699b10d0d28\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-05-26T05:41:36.586995Z","caller":"traceutil/trace.go:171","msg":"trace[597847432] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d4c96f2d-c61d-4390-b835-5699b10d0d28; range_end:; response_count:1; response_revision:1865; }","duration":"281.031979ms","start":"2026-05-26T05:41:36.305955Z","end":"2026-05-26T05:41:36.586987Z","steps":["trace[597847432] 'agreement among raft nodes before linearized reading' (duration: 280.452351ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:44.210259Z","caller":"traceutil/trace.go:171","msg":"trace[2008175451] transaction","detail":"{read_only:false; response_revision:1930; number_of_response:1; }","duration":"249.166672ms","start":"2026-05-26T05:41:43.961062Z","end":"2026-05-26T05:41:44.210229Z","steps":["trace[2008175451] 'process raft request' (duration: 249.006169ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:48.327252Z","caller":"traceutil/trace.go:171","msg":"trace[2086907520] transaction","detail":"{read_only:false; response_revision:1955; number_of_response:1; }","duration":"101.382938ms","start":"2026-05-26T05:41:48.225843Z","end":"2026-05-26T05:41:48.327226Z","steps":["trace[2086907520] 'process raft request' (duration: 101.221126ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:49.050268Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256879325914920884,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-26T05:41:49.268793Z","caller":"traceutil/trace.go:171","msg":"trace[944006269] transaction","detail":"{read_only:false; response_revision:1957; number_of_response:1; }","duration":"758.814198ms","start":"2026-05-26T05:41:48.509954Z","end":"2026-05-26T05:41:49.268768Z","steps":["trace[944006269] 'process raft request' (duration: 758.542944ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:49.268954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:48.509936Z","time spent":"758.927409ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:41:49.275539Z","caller":"traceutil/trace.go:171","msg":"trace[767817411] transaction","detail":"{read_only:false; response_revision:1958; number_of_response:1; }","duration":"764.096812ms","start":"2026-05-26T05:41:48.511418Z","end":"2026-05-26T05:41:49.275514Z","steps":["trace[767817411] 'process raft request' (duration: 763.90944ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:49.2757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:48.511402Z","time spent":"764.215023ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:41:49.275764Z","caller":"traceutil/trace.go:171","msg":"trace[1166745754] transaction","detail":"{read_only:false; response_revision:1959; number_of_response:1; }","duration":"763.691357ms","start":"2026-05-26T05:41:48.512055Z","end":"2026-05-26T05:41:49.275746Z","steps":["trace[1166745754] 'process raft request' (duration: 763.400703ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:49.275856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:48.512041Z","time spent":"763.769339ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:41:49.275997Z","caller":"traceutil/trace.go:171","msg":"trace[1805453446] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"763.565506ms","start":"2026-05-26T05:41:48.512405Z","end":"2026-05-26T05:41:49.27597Z","steps":["trace[1805453446] 'process raft request' (duration: 763.274541ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:49.276131Z","caller":"traceutil/trace.go:171","msg":"trace[506331857] transaction","detail":"{read_only:false; response_revision:1961; number_of_response:1; }","duration":"650.90776ms","start":"2026-05-26T05:41:48.625211Z","end":"2026-05-26T05:41:49.276119Z","steps":["trace[506331857] 'process raft request' (duration: 650.672988ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:49.276186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:48.512384Z","time spent":"763.710308ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:41:49.276204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:48.624726Z","time spent":"651.441847ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:41:49.276259Z","caller":"traceutil/trace.go:171","msg":"trace[273308470] transaction","detail":"{read_only:false; response_revision:1962; number_of_response:1; }","duration":"649.896068ms","start":"2026-05-26T05:41:48.626354Z","end":"2026-05-26T05:41:49.27625Z","steps":["trace[273308470] 'process raft request' (duration: 649.686266ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:49.276314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:48.626344Z","time spent":"649.942248ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:41:49.276458Z","caller":"traceutil/trace.go:171","msg":"trace[601952889] transaction","detail":"{read_only:false; response_revision:1963; number_of_response:1; }","duration":"297.122885ms","start":"2026-05-26T05:41:48.979326Z","end":"2026-05-26T05:41:49.276448Z","steps":["trace[601952889] 'process raft request' (duration: 296.887033ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:49.27663Z","caller":"traceutil/trace.go:171","msg":"trace[731362039] linearizableReadLoop","detail":"{readStateIndex:2043; appliedIndex:2036; }","duration":"727.270585ms","start":"2026-05-26T05:41:48.549349Z","end":"2026-05-26T05:41:49.276619Z","steps":["trace[731362039] 'read index received' (duration: 719.013896ms)","trace[731362039] 'applied index is now lower than readState.Index' (duration: 8.255579ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:41:49.276724Z","caller":"traceutil/trace.go:171","msg":"trace[1177979039] transaction","detail":"{read_only:false; response_revision:1964; number_of_response:1; }","duration":"162.318138ms","start":"2026-05-26T05:41:49.114397Z","end":"2026-05-26T05:41:49.276715Z","steps":["trace[1177979039] 'process raft request' (duration: 162.015415ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:49.276892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.734187ms","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-26T05:41:49.276931Z","caller":"traceutil/trace.go:171","msg":"trace[20380132] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1964; }","duration":"597.804708ms","start":"2026-05-26T05:41:48.679117Z","end":"2026-05-26T05:41:49.276922Z","steps":["trace[20380132] 'agreement among raft nodes before linearized reading' (duration: 597.669876ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:49.276968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:48.679104Z","time spent":"597.858498ms","remote":"127.0.0.1:60864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-26T05:41:49.277038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.837712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T05:41:49.277055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.71344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11989"} {"level":"warn","ts":"2026-05-26T05:41:49.276925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.062635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-05-26T05:41:49.277085Z","caller":"traceutil/trace.go:171","msg":"trace[713840409] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1964; }","duration":"566.898552ms","start":"2026-05-26T05:41:48.710176Z","end":"2026-05-26T05:41:49.277074Z","steps":["trace[713840409] 'agreement among raft nodes before linearized reading' (duration: 566.827831ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:49.277095Z","caller":"traceutil/trace.go:171","msg":"trace[746908186] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1964; }","duration":"727.771331ms","start":"2026-05-26T05:41:48.549311Z","end":"2026-05-26T05:41:49.277082Z","steps":["trace[746908186] 'agreement among raft nodes before linearized reading' (duration: 727.64264ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:49.277104Z","caller":"traceutil/trace.go:171","msg":"trace[396369961] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1964; }","duration":"123.275307ms","start":"2026-05-26T05:41:49.153818Z","end":"2026-05-26T05:41:49.277093Z","steps":["trace[396369961] 'agreement among raft nodes before linearized reading' (duration: 123.003883ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:49.277121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:48.710165Z","time spent":"566.944103ms","remote":"127.0.0.1:52802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-26T05:41:49.277156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:41:48.549293Z","time spent":"727.852913ms","remote":"127.0.0.1:52998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12012,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-05-26T05:41:49.27733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.273708ms","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-26T05:41:49.277369Z","caller":"traceutil/trace.go:171","msg":"trace[1167515372] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:1964; }","duration":"225.377019ms","start":"2026-05-26T05:41:49.051982Z","end":"2026-05-26T05:41:49.277359Z","steps":["trace[1167515372] 'agreement among raft nodes before linearized reading' (duration: 225.301638ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:55.432861Z","caller":"traceutil/trace.go:171","msg":"trace[414261526] transaction","detail":"{read_only:false; response_revision:2001; number_of_response:1; }","duration":"100.640456ms","start":"2026-05-26T05:41:55.332194Z","end":"2026-05-26T05:41:55.432835Z","steps":["trace[414261526] 'process raft request' (duration: 100.435863ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:55.433167Z","caller":"traceutil/trace.go:171","msg":"trace[788397294] transaction","detail":"{read_only:false; response_revision:2002; number_of_response:1; }","duration":"100.871678ms","start":"2026-05-26T05:41:55.332272Z","end":"2026-05-26T05:41:55.433144Z","steps":["trace[788397294] 'process raft request' (duration: 100.504704ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:55.433439Z","caller":"traceutil/trace.go:171","msg":"trace[1641826472] transaction","detail":"{read_only:false; response_revision:2003; number_of_response:1; }","duration":"100.709456ms","start":"2026-05-26T05:41:55.332716Z","end":"2026-05-26T05:41:55.433425Z","steps":["trace[1641826472] 'process raft request' (duration: 100.327592ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:42:00.221002Z","caller":"traceutil/trace.go:171","msg":"trace[1576078863] linearizableReadLoop","detail":"{readStateIndex:2121; appliedIndex:2120; }","duration":"204.690569ms","start":"2026-05-26T05:42:00.016286Z","end":"2026-05-26T05:42:00.220977Z","steps":["trace[1576078863] 'read index received' (duration: 204.474246ms)","trace[1576078863] 'applied index is now lower than readState.Index' (duration: 215.423µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:42:00.22109Z","caller":"traceutil/trace.go:171","msg":"trace[423907964] transaction","detail":"{read_only:false; response_revision:2039; number_of_response:1; }","duration":"214.093838ms","start":"2026-05-26T05:42:00.006965Z","end":"2026-05-26T05:42:00.221058Z","steps":["trace[423907964] 'process raft request' (duration: 213.848245ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:00.221234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.916641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T05:42:00.221307Z","caller":"traceutil/trace.go:171","msg":"trace[1801245381] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:2039; }","duration":"205.011792ms","start":"2026-05-26T05:42:00.016276Z","end":"2026-05-26T05:42:00.221288Z","steps":["trace[1801245381] 'agreement among raft nodes before linearized reading' (duration: 204.871821ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:00.221241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.978088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:42:00.221434Z","caller":"traceutil/trace.go:171","msg":"trace[1322153989] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:2039; }","duration":"171.1382ms","start":"2026-05-26T05:42:00.050244Z","end":"2026-05-26T05:42:00.221383Z","steps":["trace[1322153989] 'agreement among raft nodes before linearized reading' (duration: 170.951278ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:42:00.846455Z","caller":"traceutil/trace.go:171","msg":"trace[310454856] linearizableReadLoop","detail":"{readStateIndex:2124; appliedIndex:2122; }","duration":"249.872991ms","start":"2026-05-26T05:42:00.596558Z","end":"2026-05-26T05:42:00.846431Z","steps":["trace[310454856] 'read index received' (duration: 15.59872ms)","trace[310454856] 'applied index is now lower than readState.Index' (duration: 234.272741ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:42:00.846489Z","caller":"traceutil/trace.go:171","msg":"trace[882788443] transaction","detail":"{read_only:false; response_revision:2042; number_of_response:1; }","duration":"265.748035ms","start":"2026-05-26T05:42:00.580715Z","end":"2026-05-26T05:42:00.846463Z","steps":["trace[882788443] 'process raft request' (duration: 264.720093ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:00.846791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.216185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:42:00.846845Z","caller":"traceutil/trace.go:171","msg":"trace[1618653186] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:2042; }","duration":"250.322077ms","start":"2026-05-26T05:42:00.596508Z","end":"2026-05-26T05:42:00.84683Z","steps":["trace[1618653186] 'agreement among raft nodes before linearized reading' (duration: 250.034944ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:00.846846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.255678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:42:00.846908Z","caller":"traceutil/trace.go:171","msg":"trace[625168611] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2042; }","duration":"137.403719ms","start":"2026-05-26T05:42:00.709487Z","end":"2026-05-26T05:42:00.84689Z","steps":["trace[625168611] 'agreement among raft nodes before linearized reading' (duration: 137.220437ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:42:04.755653Z","caller":"traceutil/trace.go:171","msg":"trace[2136998640] transaction","detail":"{read_only:false; response_revision:2064; number_of_response:1; }","duration":"123.625151ms","start":"2026-05-26T05:42:04.632002Z","end":"2026-05-26T05:42:04.755627Z","steps":["trace[2136998640] 'process raft request' (duration: 123.476509ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:10.843155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.845411ms","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-26T05:42:10.843247Z","caller":"traceutil/trace.go:171","msg":"trace[1472383852] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2094; }","duration":"237.981913ms","start":"2026-05-26T05:42:10.605245Z","end":"2026-05-26T05:42:10.843227Z","steps":["trace[1472383852] 'range keys from in-memory index tree' (duration: 237.657949ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:10.843793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.201221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:42:10.843842Z","caller":"traceutil/trace.go:171","msg":"trace[2059176747] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2094; }","duration":"133.293151ms","start":"2026-05-26T05:42:10.710535Z","end":"2026-05-26T05:42:10.843828Z","steps":["trace[2059176747] 'range keys from in-memory index tree' (duration: 133.072859ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:11.390206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.292103ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-26T05:42:11.424547Z","caller":"traceutil/trace.go:171","msg":"trace[923476713] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"304.502638ms","start":"2026-05-26T05:42:11.120018Z","end":"2026-05-26T05:42:11.424521Z","steps":["trace[923476713] 'process raft request' (duration: 304.353686ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:11.424686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:11.119993Z","time spent":"304.619459ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:42:11.803911Z","caller":"traceutil/trace.go:171","msg":"trace[799655854] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"280.171096ms","start":"2026-05-26T05:42:11.523706Z","end":"2026-05-26T05:42:11.803877Z","steps":["trace[799655854] 'process raft request' (duration: 280.029214ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:42:11.839707Z","caller":"traceutil/trace.go:171","msg":"trace[1045272692] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"258.919819ms","start":"2026-05-26T05:42:11.580763Z","end":"2026-05-26T05:42:11.839683Z","steps":["trace[1045272692] 'process raft request' (duration: 258.832778ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:42:11.839731Z","caller":"traceutil/trace.go:171","msg":"trace[692102081] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"296.275475ms","start":"2026-05-26T05:42:11.543419Z","end":"2026-05-26T05:42:11.839695Z","steps":["trace[692102081] 'process raft request' (duration: 296.043722ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:42:11.839993Z","caller":"traceutil/trace.go:171","msg":"trace[961000566] linearizableReadLoop","detail":"{readStateIndex:2185; appliedIndex:2183; }","duration":"233.019089ms","start":"2026-05-26T05:42:11.606621Z","end":"2026-05-26T05:42:11.83964Z","steps":["trace[961000566] 'read index received' (duration: 197.290041ms)","trace[961000566] 'applied index is now lower than readState.Index' (duration: 35.728068ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:42:11.840073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.439473ms","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-26T05:42:11.840145Z","caller":"traceutil/trace.go:171","msg":"trace[969935341] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2100; }","duration":"233.577046ms","start":"2026-05-26T05:42:11.60655Z","end":"2026-05-26T05:42:11.840127Z","steps":["trace[969935341] 'agreement among raft nodes before linearized reading' (duration: 233.361053ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:11.84045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.586451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-26T05:42:11.840534Z","caller":"traceutil/trace.go:171","msg":"trace[1295999091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2100; }","duration":"229.724302ms","start":"2026-05-26T05:42:11.610787Z","end":"2026-05-26T05:42:11.840512Z","steps":["trace[1295999091] 'agreement among raft nodes before linearized reading' (duration: 229.438079ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:11.841327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.716373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-26T05:42:11.841711Z","caller":"traceutil/trace.go:171","msg":"trace[1414785657] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2100; }","duration":"231.141678ms","start":"2026-05-26T05:42:11.610545Z","end":"2026-05-26T05:42:11.841686Z","steps":["trace[1414785657] 'agreement among raft nodes before linearized reading' (duration: 229.569591ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:12.226289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.753893ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:42:12.226632Z","caller":"traceutil/trace.go:171","msg":"trace[1316168597] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"382.845474ms","start":"2026-05-26T05:42:11.843752Z","end":"2026-05-26T05:42:12.226597Z","steps":["trace[1316168597] 'process raft request' (duration: 59.506544ms)","trace[1316168597] 'compare' (duration: 322.618252ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:42:12.226783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:11.843715Z","time spent":"382.991185ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:42:12.226895Z","caller":"traceutil/trace.go:171","msg":"trace[1474138534] linearizableReadLoop","detail":"{readStateIndex:2188; appliedIndex:2185; }","duration":"377.10888ms","start":"2026-05-26T05:42:11.849768Z","end":"2026-05-26T05:42:12.226877Z","steps":["trace[1474138534] 'read index received' (duration: 53.505328ms)","trace[1474138534] 'applied index is now lower than readState.Index' (duration: 323.602632ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:42:12.226914Z","caller":"traceutil/trace.go:171","msg":"trace[856944452] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"380.78199ms","start":"2026-05-26T05:42:11.846114Z","end":"2026-05-26T05:42:12.226896Z","steps":["trace[856944452] 'process raft request' (duration: 380.506757ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:12.227037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:11.846099Z","time spent":"380.880331ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:42:12.227126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.351052ms","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-26T05:42:12.227196Z","caller":"traceutil/trace.go:171","msg":"trace[1693046503] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2103; }","duration":"377.448184ms","start":"2026-05-26T05:42:11.849729Z","end":"2026-05-26T05:42:12.227177Z","steps":["trace[1693046503] 'agreement among raft nodes before linearized reading' (duration: 377.266902ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:42:12.227226Z","caller":"traceutil/trace.go:171","msg":"trace[469628627] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"382.025584ms","start":"2026-05-26T05:42:11.845189Z","end":"2026-05-26T05:42:12.227215Z","steps":["trace[469628627] 'process raft request' (duration: 381.348806ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:12.227232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:11.849713Z","time spent":"377.509284ms","remote":"127.0.0.1:60864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-26T05:42:12.227321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:11.845164Z","time spent":"382.084495ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:42:12.542314Z","caller":"traceutil/trace.go:171","msg":"trace[1543902306] linearizableReadLoop","detail":"{readStateIndex:2189; appliedIndex:2188; }","duration":"315.321076ms","start":"2026-05-26T05:42:12.226967Z","end":"2026-05-26T05:42:12.542288Z","steps":["trace[1543902306] 'read index received' (duration: 220.968487ms)","trace[1543902306] 'applied index is now lower than readState.Index' (duration: 94.351579ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:42:12.542346Z","caller":"traceutil/trace.go:171","msg":"trace[762777619] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"523.362151ms","start":"2026-05-26T05:42:12.018953Z","end":"2026-05-26T05:42:12.542315Z","steps":["trace[762777619] 'process raft request' (duration: 428.967161ms)","trace[762777619] 'compare' (duration: 94.169777ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:42:12.542634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.243733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:42:12.542684Z","caller":"traceutil/trace.go:171","msg":"trace[944987881] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2105; }","duration":"268.322983ms","start":"2026-05-26T05:42:12.274347Z","end":"2026-05-26T05:42:12.54267Z","steps":["trace[944987881] 'agreement among raft nodes before linearized reading' (duration: 268.216692ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:12.542635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:12.018936Z","time spent":"523.611523ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:42:12.542725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.627887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"info","ts":"2026-05-26T05:42:12.542833Z","caller":"traceutil/trace.go:171","msg":"trace[1365551103] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2105; }","duration":"639.743259ms","start":"2026-05-26T05:42:11.903041Z","end":"2026-05-26T05:42:12.542784Z","steps":["trace[1365551103] 'agreement among raft nodes before linearized reading' (duration: 639.367665ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:12.54291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.815388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-26T05:42:12.542884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:11.903028Z","time spent":"639.844149ms","remote":"127.0.0.1:53004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2011,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"warn","ts":"2026-05-26T05:42:12.54273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.951398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T05:42:12.543006Z","caller":"traceutil/trace.go:171","msg":"trace[378345626] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:2105; }","duration":"222.973629ms","start":"2026-05-26T05:42:12.319982Z","end":"2026-05-26T05:42:12.542956Z","steps":["trace[378345626] 'agreement among raft nodes before linearized reading' (duration: 222.702937ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:42:12.54302Z","caller":"traceutil/trace.go:171","msg":"trace[509514716] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:2105; }","duration":"542.291102ms","start":"2026-05-26T05:42:12.000705Z","end":"2026-05-26T05:42:12.542996Z","steps":["trace[509514716] 'agreement among raft nodes before linearized reading' (duration: 541.609954ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:12.543088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:12.000682Z","time spent":"542.381782ms","remote":"127.0.0.1:53176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":90,"response size":30,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"info","ts":"2026-05-26T05:42:13.192856Z","caller":"traceutil/trace.go:171","msg":"trace[540652904] linearizableReadLoop","detail":"{readStateIndex:2191; appliedIndex:2190; }","duration":"313.956226ms","start":"2026-05-26T05:42:12.878874Z","end":"2026-05-26T05:42:13.19283Z","steps":["trace[540652904] 'read index received' (duration: 313.744193ms)","trace[540652904] 'applied index is now lower than readState.Index' (duration: 211.053µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:42:13.193011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.099808ms","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-26T05:42:13.193054Z","caller":"traceutil/trace.go:171","msg":"trace[1033450804] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:2106; }","duration":"314.203188ms","start":"2026-05-26T05:42:12.87884Z","end":"2026-05-26T05:42:13.193043Z","steps":["trace[1033450804] 'agreement among raft nodes before linearized reading' (duration: 314.097117ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:13.193092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:12.878828Z","time spent":"314.253529ms","remote":"127.0.0.1:52896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"info","ts":"2026-05-26T05:42:13.19297Z","caller":"traceutil/trace.go:171","msg":"trace[1793886350] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"321.131335ms","start":"2026-05-26T05:42:12.871804Z","end":"2026-05-26T05:42:13.192935Z","steps":["trace[1793886350] 'process raft request' (duration: 320.780031ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:13.193456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:12.87178Z","time spent":"321.524519ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:42:13.950591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:13.296514Z","time spent":"654.072132ms","remote":"127.0.0.1:39034","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-26T05:42:13.950834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.450395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T05:42:13.950901Z","caller":"traceutil/trace.go:171","msg":"trace[2019263046] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:2106; }","duration":"303.565706ms","start":"2026-05-26T05:42:13.64732Z","end":"2026-05-26T05:42:13.950886Z","steps":["trace[2019263046] 'count revisions from in-memory index tree' (duration: 303.379194ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:13.950947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:13.647301Z","time spent":"303.634437ms","remote":"127.0.0.1:52932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":9,"response size":30,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-05-26T05:42:13.951054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.206764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:42:13.951085Z","caller":"traceutil/trace.go:171","msg":"trace[427164515] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2106; }","duration":"241.262035ms","start":"2026-05-26T05:42:13.709814Z","end":"2026-05-26T05:42:13.951076Z","steps":["trace[427164515] 'range keys from in-memory index tree' (duration: 241.076362ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:13.951639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.395541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-26T05:42:13.95167Z","caller":"traceutil/trace.go:171","msg":"trace[1342511094] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2106; }","duration":"483.428051ms","start":"2026-05-26T05:42:13.468234Z","end":"2026-05-26T05:42:13.951662Z","steps":["trace[1342511094] 'range keys from in-memory index tree' (duration: 483.255449ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:13.951692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:13.468172Z","time spent":"483.511931ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T05:42:13.951833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.320392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b30722bad8db4a\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-05-26T05:42:13.951859Z","caller":"traceutil/trace.go:171","msg":"trace[47847040] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18b30722bad8db4a; range_end:; response_count:1; response_revision:2106; }","duration":"256.378932ms","start":"2026-05-26T05:42:13.695474Z","end":"2026-05-26T05:42:13.951853Z","steps":["trace[47847040] 'range keys from in-memory index tree' (duration: 255.712225ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:14.465065Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256879325914921222,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-26T05:42:14.706033Z","caller":"traceutil/trace.go:171","msg":"trace[663608068] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"896.94845ms","start":"2026-05-26T05:42:13.809058Z","end":"2026-05-26T05:42:14.706007Z","steps":["trace[663608068] 'process raft request' (duration: 896.744238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:14.706191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:13.809034Z","time spent":"897.077412ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:42:15.952764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000315162s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-26T05:42:15.952872Z","caller":"traceutil/trace.go:171","msg":"trace[1010865800] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000476484s","start":"2026-05-26T05:42:13.952376Z","end":"2026-05-26T05:42:15.952852Z","steps":["trace[1010865800] 'agreement among raft nodes before linearized reading' (duration: 2.000323733s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:15.952921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:13.952367Z","time spent":"2.000544425s","remote":"127.0.0.1:52800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/26 05:42:15 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-26T05:42:16.111127Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.405257424s","expected-duration":"1s"} {"level":"info","ts":"2026-05-26T05:42:16.111796Z","caller":"traceutil/trace.go:171","msg":"trace[439676798] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"2.267009975s","start":"2026-05-26T05:42:13.844763Z","end":"2026-05-26T05:42:16.111773Z","steps":["trace[439676798] 'process raft request' (duration: 2.266645891s)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:42:16.112025Z","caller":"traceutil/trace.go:171","msg":"trace[151428805] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"2.266213837s","start":"2026-05-26T05:42:13.845786Z","end":"2026-05-26T05:42:16.111999Z","steps":["trace[151428805] 'process raft request' (duration: 2.265915013s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:16.112329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:13.845779Z","time spent":"2.26646854s","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:42:16.112401Z","caller":"traceutil/trace.go:171","msg":"trace[1457054146] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"2.15829429s","start":"2026-05-26T05:42:13.954083Z","end":"2026-05-26T05:42:16.112378Z","steps":["trace[1457054146] 'process raft request' (duration: 2.157862526s)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:42:16.112582Z","caller":"traceutil/trace.go:171","msg":"trace[440994056] linearizableReadLoop","detail":"{readStateIndex:2196; appliedIndex:2191; }","duration":"2.16012865s","start":"2026-05-26T05:42:13.952393Z","end":"2026-05-26T05:42:16.112522Z","steps":["trace[440994056] 'read index received' (duration: 753.387599ms)","trace[440994056] 'applied index is now lower than readState.Index' (duration: 1.406740171s)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:42:16.112548Z","caller":"traceutil/trace.go:171","msg":"trace[1353125182] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"2.157292239s","start":"2026-05-26T05:42:13.95523Z","end":"2026-05-26T05:42:16.112523Z","steps":["trace[1353125182] 'process raft request' (duration: 2.157010596s)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:42:16.112779Z","caller":"traceutil/trace.go:171","msg":"trace[63525216] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"1.564931729s","start":"2026-05-26T05:42:14.547835Z","end":"2026-05-26T05:42:16.112767Z","steps":["trace[63525216] 'process raft request' (duration: 1.564572686s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:16.112968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:14.547808Z","time spent":"1.56504185s","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:42:16.113091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.147271866s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T05:42:16.112028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:13.844734Z","time spent":"2.267134196s","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:42:16.113225Z","caller":"traceutil/trace.go:171","msg":"trace[84755764] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:2112; }","duration":"2.147433889s","start":"2026-05-26T05:42:13.965779Z","end":"2026-05-26T05:42:16.113213Z","steps":["trace[84755764] 'agreement among raft nodes before linearized reading' (duration: 2.147263557s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:16.113388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.067646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.132\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-05-26T05:42:16.11337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:13.965765Z","time spent":"2.147591191s","remote":"127.0.0.1:52944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-05-26T05:42:16.11338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.789731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:42:16.113434Z","caller":"traceutil/trace.go:171","msg":"trace[875101520] range","detail":"{range_begin:/registry/masterleases/199.204.45.132; range_end:; response_count:1; response_revision:2112; }","duration":"341.145967ms","start":"2026-05-26T05:42:15.772276Z","end":"2026-05-26T05:42:16.113422Z","steps":["trace[875101520] 'agreement among raft nodes before linearized reading' (duration: 341.061116ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:42:16.113449Z","caller":"traceutil/trace.go:171","msg":"trace[2046795964] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2112; }","duration":"152.890782ms","start":"2026-05-26T05:42:15.960541Z","end":"2026-05-26T05:42:16.113432Z","steps":["trace[2046795964] 'agreement among raft nodes before linearized reading' (duration: 152.793451ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:16.113466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:15.772224Z","time spent":"341.235857ms","remote":"127.0.0.1:52832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.132\" "} {"level":"warn","ts":"2026-05-26T05:42:16.113629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.882749072s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-26T05:42:16.11368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.041495578s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-26T05:42:16.113631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.987898905s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:42:16.113726Z","caller":"traceutil/trace.go:171","msg":"trace[1110945599] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:2112; }","duration":"1.988042967s","start":"2026-05-26T05:42:14.125673Z","end":"2026-05-26T05:42:16.113716Z","steps":["trace[1110945599] 'agreement among raft nodes before linearized reading' (duration: 1.987912206s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:16.113786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:13.955224Z","time spent":"2.157573562s","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:42:16.11372Z","caller":"traceutil/trace.go:171","msg":"trace[1789917486] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:2112; }","duration":"2.041580428s","start":"2026-05-26T05:42:14.07213Z","end":"2026-05-26T05:42:16.113711Z","steps":["trace[1789917486] 'agreement among raft nodes before linearized reading' (duration: 2.041514417s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:16.112697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:13.954068Z","time spent":"2.158456632s","remote":"127.0.0.1:52882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:42:16.113884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.88338296s","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-26T05:42:16.113993Z","caller":"traceutil/trace.go:171","msg":"trace[1477429349] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2112; }","duration":"1.883511751s","start":"2026-05-26T05:42:14.230463Z","end":"2026-05-26T05:42:16.113975Z","steps":["trace[1477429349] 'agreement among raft nodes before linearized reading' (duration: 1.883198517s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:16.114049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.129136476s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-26T05:42:16.113889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.716829849s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12386"} {"level":"info","ts":"2026-05-26T05:42:16.114109Z","caller":"traceutil/trace.go:171","msg":"trace[586493362] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:2112; }","duration":"2.129202548s","start":"2026-05-26T05:42:13.984879Z","end":"2026-05-26T05:42:16.114082Z","steps":["trace[586493362] 'agreement among raft nodes before linearized reading' (duration: 2.129133357s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:16.114617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:13.984868Z","time spent":"2.129729943s","remote":"127.0.0.1:43068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":2,"response size":30,"request content":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true "} {"level":"info","ts":"2026-05-26T05:42:16.113686Z","caller":"traceutil/trace.go:171","msg":"trace[572320805] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2112; }","duration":"1.883173558s","start":"2026-05-26T05:42:14.230498Z","end":"2026-05-26T05:42:16.113672Z","steps":["trace[572320805] 'agreement among raft nodes before linearized reading' (duration: 1.882606021s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:16.114794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:14.23049Z","time spent":"1.88429471s","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-26T05:42:16.114062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:14.23045Z","time spent":"1.883596331s","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T05:42:16.113864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:14.072109Z","time spent":"2.041740939s","remote":"127.0.0.1:53104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":30,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-26T05:42:16.114144Z","caller":"traceutil/trace.go:171","msg":"trace[464870075] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2112; }","duration":"1.717105431s","start":"2026-05-26T05:42:14.39701Z","end":"2026-05-26T05:42:16.114115Z","steps":["trace[464870075] 'agreement among raft nodes before linearized reading' (duration: 1.716799798s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:16.114942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:14.396988Z","time spent":"1.717941011s","remote":"127.0.0.1:52998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12409,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-05-26T05:42:16.114207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.883738763s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-26T05:42:16.115039Z","caller":"traceutil/trace.go:171","msg":"trace[2038459103] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2112; }","duration":"1.884568193s","start":"2026-05-26T05:42:14.230458Z","end":"2026-05-26T05:42:16.115026Z","steps":["trace[2038459103] 'agreement among raft nodes before linearized reading' (duration: 1.883677902s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:16.115077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:14.230402Z","time spent":"1.884664014s","remote":"127.0.0.1:53088","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-26T05:42:16.114296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.874178927s","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-26T05:42:16.11516Z","caller":"traceutil/trace.go:171","msg":"trace[496697963] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2112; }","duration":"1.875084018s","start":"2026-05-26T05:42:14.240067Z","end":"2026-05-26T05:42:16.115151Z","steps":["trace[496697963] 'agreement among raft nodes before linearized reading' (duration: 1.873765653s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:16.115187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:14.240045Z","time spent":"1.875134538s","remote":"127.0.0.1:60864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-26T05:42:16.114341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:14.125655Z","time spent":"1.988099717s","remote":"127.0.0.1:41276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-26T05:42:16.113304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"915.597848ms","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-26T05:42:16.115264Z","caller":"traceutil/trace.go:171","msg":"trace[684280115] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2112; }","duration":"917.593499ms","start":"2026-05-26T05:42:15.197657Z","end":"2026-05-26T05:42:16.11525Z","steps":["trace[684280115] 'agreement among raft nodes before linearized reading' (duration: 915.539876ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:16.115309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:15.197635Z","time spent":"917.66398ms","remote":"127.0.0.1:53088","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-26T05:43:24.627615Z","caller":"traceutil/trace.go:171","msg":"trace[684301756] transaction","detail":"{read_only:false; response_revision:2481; number_of_response:1; }","duration":"104.54073ms","start":"2026-05-26T05:43:24.523044Z","end":"2026-05-26T05:43:24.627584Z","steps":["trace[684301756] 'process raft request' (duration: 27.977251ms)","trace[684301756] 'compare' (duration: 76.437858ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:43:24.659641Z","caller":"traceutil/trace.go:171","msg":"trace[689915441] transaction","detail":"{read_only:false; response_revision:2482; number_of_response:1; }","duration":"135.451958ms","start":"2026-05-26T05:43:24.524167Z","end":"2026-05-26T05:43:24.659619Z","steps":["trace[689915441] 'process raft request' (duration: 135.305177ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:43:24.659908Z","caller":"traceutil/trace.go:171","msg":"trace[376900271] transaction","detail":"{read_only:false; response_revision:2483; number_of_response:1; }","duration":"135.955483ms","start":"2026-05-26T05:43:24.523941Z","end":"2026-05-26T05:43:24.659896Z","steps":["trace[376900271] 'process raft request' (duration: 135.63889ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:43:24.660047Z","caller":"traceutil/trace.go:171","msg":"trace[61722722] transaction","detail":"{read_only:false; response_revision:2484; number_of_response:1; }","duration":"135.556359ms","start":"2026-05-26T05:43:24.524457Z","end":"2026-05-26T05:43:24.660013Z","steps":["trace[61722722] 'process raft request' (duration: 135.336967ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:43:24.660126Z","caller":"traceutil/trace.go:171","msg":"trace[1183546417] transaction","detail":"{read_only:false; response_revision:2485; number_of_response:1; }","duration":"134.299507ms","start":"2026-05-26T05:43:24.525793Z","end":"2026-05-26T05:43:24.660093Z","steps":["trace[1183546417] 'process raft request' (duration: 134.070985ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:43:36.53755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.532857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-9ghtg\" ","response":"range_response_count:1 size:7818"} {"level":"info","ts":"2026-05-26T05:43:36.53762Z","caller":"traceutil/trace.go:171","msg":"trace[907383139] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-9ghtg; range_end:; response_count:1; response_revision:2584; }","duration":"168.650179ms","start":"2026-05-26T05:43:36.368955Z","end":"2026-05-26T05:43:36.537605Z","steps":["trace[907383139] 'range keys from in-memory index tree' (duration: 168.348016ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:43:45.173505Z","caller":"traceutil/trace.go:171","msg":"trace[1476335106] linearizableReadLoop","detail":"{readStateIndex:2798; appliedIndex:2797; }","duration":"120.720972ms","start":"2026-05-26T05:43:45.052747Z","end":"2026-05-26T05:43:45.173468Z","steps":["trace[1476335106] 'read index received' (duration: 120.385039ms)","trace[1476335106] 'applied index is now lower than readState.Index' (duration: 334.223µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:43:45.173729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.935715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:43:45.173847Z","caller":"traceutil/trace.go:171","msg":"trace[1833492102] transaction","detail":"{read_only:false; response_revision:2692; number_of_response:1; }","duration":"131.297202ms","start":"2026-05-26T05:43:45.042515Z","end":"2026-05-26T05:43:45.173812Z","steps":["trace[1833492102] 'process raft request' (duration: 130.717966ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:43:45.173896Z","caller":"traceutil/trace.go:171","msg":"trace[154930822] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:2692; }","duration":"121.199337ms","start":"2026-05-26T05:43:45.052677Z","end":"2026-05-26T05:43:45.173876Z","steps":["trace[154930822] 'agreement among raft nodes before linearized reading' (duration: 120.947574ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:43:46.137126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:43:45.777646Z","time spent":"359.467261ms","remote":"127.0.0.1:52832","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-26T05:44:06.932046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.719693ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:44:06.932839Z","caller":"traceutil/trace.go:171","msg":"trace[1106546026] transaction","detail":"{read_only:false; response_revision:2813; number_of_response:1; }","duration":"119.260869ms","start":"2026-05-26T05:44:06.813174Z","end":"2026-05-26T05:44:06.932435Z","steps":["trace[1106546026] 'compare' (duration: 110.378232ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:44:12.615734Z","caller":"traceutil/trace.go:171","msg":"trace[1857325656] transaction","detail":"{read_only:false; response_revision:2839; number_of_response:1; }","duration":"158.700526ms","start":"2026-05-26T05:44:12.457007Z","end":"2026-05-26T05:44:12.615708Z","steps":["trace[1857325656] 'process raft request' (duration: 158.560462ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:44:19.44614Z","caller":"traceutil/trace.go:171","msg":"trace[786799756] transaction","detail":"{read_only:false; response_revision:2872; number_of_response:1; }","duration":"670.470276ms","start":"2026-05-26T05:44:18.775627Z","end":"2026-05-26T05:44:19.446097Z","steps":["trace[786799756] 'process raft request' (duration: 646.510294ms)","trace[786799756] 'compare' (duration: 23.141468ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:44:19.446296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:44:18.775594Z","time spent":"670.615141ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:44:19.50268Z","caller":"traceutil/trace.go:171","msg":"trace[944111359] transaction","detail":"{read_only:false; response_revision:2873; number_of_response:1; }","duration":"719.227204ms","start":"2026-05-26T05:44:18.783421Z","end":"2026-05-26T05:44:19.502648Z","steps":["trace[944111359] 'process raft request' (duration: 718.758061ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:44:19.502855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:44:18.783398Z","time spent":"719.369709ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:44:19.503202Z","caller":"traceutil/trace.go:171","msg":"trace[1207193466] linearizableReadLoop","detail":"{readStateIndex:2987; appliedIndex:2984; }","duration":"517.265021ms","start":"2026-05-26T05:44:18.985922Z","end":"2026-05-26T05:44:19.503187Z","steps":["trace[1207193466] 'read index received' (duration: 436.190226ms)","trace[1207193466] 'applied index is now lower than readState.Index' (duration: 81.073895ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:44:19.503507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.047889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-26T05:44:19.50374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.800286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-26T05:44:19.503736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.140322ms","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":"info","ts":"2026-05-26T05:44:19.503747Z","caller":"traceutil/trace.go:171","msg":"trace[723559919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2875; }","duration":"477.318748ms","start":"2026-05-26T05:44:19.026415Z","end":"2026-05-26T05:44:19.503734Z","steps":["trace[723559919] 'agreement among raft nodes before linearized reading' (duration: 476.994808ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:44:19.50376Z","caller":"traceutil/trace.go:171","msg":"trace[520999244] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2875; }","duration":"473.876588ms","start":"2026-05-26T05:44:19.029877Z","end":"2026-05-26T05:44:19.503754Z","steps":["trace[520999244] 'agreement among raft nodes before linearized reading' (duration: 473.827216ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:44:19.503778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:44:19.029846Z","time spent":"473.928209ms","remote":"127.0.0.1:53088","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-26T05:44:19.503773Z","caller":"traceutil/trace.go:171","msg":"trace[1355709145] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2875; }","duration":"227.220965ms","start":"2026-05-26T05:44:19.276539Z","end":"2026-05-26T05:44:19.50376Z","steps":["trace[1355709145] 'agreement among raft nodes before linearized reading' (duration: 227.145323ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:44:19.50378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:44:19.026341Z","time spent":"477.428281ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-26T05:44:19.503544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.840862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-26T05:44:19.503867Z","caller":"traceutil/trace.go:171","msg":"trace[2076984150] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2875; }","duration":"466.187862ms","start":"2026-05-26T05:44:19.037674Z","end":"2026-05-26T05:44:19.503862Z","steps":["trace[2076984150] 'agreement among raft nodes before linearized reading' (duration: 465.80037ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:44:19.503885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:44:19.037664Z","time spent":"466.216403ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T05:44:19.503863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.375315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-05-26T05:44:19.503593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.864198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T05:44:19.503926Z","caller":"traceutil/trace.go:171","msg":"trace[401116446] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:2875; }","duration":"389.230859ms","start":"2026-05-26T05:44:19.11469Z","end":"2026-05-26T05:44:19.503921Z","steps":["trace[401116446] 'agreement among raft nodes before linearized reading' (duration: 388.873018ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:44:19.50362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.679758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T05:44:19.503948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:44:19.114678Z","time spent":"389.26459ms","remote":"127.0.0.1:52966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":21,"response size":30,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"info","ts":"2026-05-26T05:44:19.503936Z","caller":"traceutil/trace.go:171","msg":"trace[1769719132] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2875; }","duration":"470.487729ms","start":"2026-05-26T05:44:19.03343Z","end":"2026-05-26T05:44:19.503918Z","steps":["trace[1769719132] 'agreement among raft nodes before linearized reading' (duration: 470.241432ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:44:19.503984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:44:19.033418Z","time spent":"470.55769ms","remote":"127.0.0.1:53088","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-26T05:44:19.504102Z","caller":"traceutil/trace.go:171","msg":"trace[353420550] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:2875; }","duration":"453.011747ms","start":"2026-05-26T05:44:19.050935Z","end":"2026-05-26T05:44:19.503947Z","steps":["trace[353420550] 'agreement among raft nodes before linearized reading' (duration: 452.670438ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:44:19.503587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.654191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-26T05:44:19.504136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:44:19.050914Z","time spent":"453.213923ms","remote":"127.0.0.1:60678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true "} {"level":"info","ts":"2026-05-26T05:44:19.504244Z","caller":"traceutil/trace.go:171","msg":"trace[1586886691] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2875; }","duration":"518.374544ms","start":"2026-05-26T05:44:18.985856Z","end":"2026-05-26T05:44:19.50423Z","steps":["trace[1586886691] 'agreement among raft nodes before linearized reading' (duration: 517.548989ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:44:19.504591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:44:18.985801Z","time spent":"518.779555ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T05:44:19.503663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.141316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:44:19.504801Z","caller":"traceutil/trace.go:171","msg":"trace[272821358] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2875; }","duration":"152.31507ms","start":"2026-05-26T05:44:19.352477Z","end":"2026-05-26T05:44:19.504792Z","steps":["trace[272821358] 'agreement among raft nodes before linearized reading' (duration: 151.163437ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:44:19.503686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.00047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:44:19.504924Z","caller":"traceutil/trace.go:171","msg":"trace[1855009180] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:2875; }","duration":"212.260195ms","start":"2026-05-26T05:44:19.292657Z","end":"2026-05-26T05:44:19.504917Z","steps":["trace[1855009180] 'agreement among raft nodes before linearized reading' (duration: 211.01418ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:44:19.503672Z","caller":"traceutil/trace.go:171","msg":"trace[390552589] transaction","detail":"{read_only:false; response_revision:2875; number_of_response:1; }","duration":"193.891339ms","start":"2026-05-26T05:44:19.30976Z","end":"2026-05-26T05:44:19.503651Z","steps":["trace[390552589] 'process raft request' (duration: 193.376033ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:44:19.503515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.965168ms","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-26T05:44:19.505301Z","caller":"traceutil/trace.go:171","msg":"trace[1664173023] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2875; }","duration":"239.7067ms","start":"2026-05-26T05:44:19.265502Z","end":"2026-05-26T05:44:19.505209Z","steps":["trace[1664173023] 'agreement among raft nodes before linearized reading' (duration: 237.929738ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:44:19.503652Z","caller":"traceutil/trace.go:171","msg":"trace[1859275438] transaction","detail":"{read_only:false; response_revision:2874; number_of_response:1; }","duration":"718.260306ms","start":"2026-05-26T05:44:18.785382Z","end":"2026-05-26T05:44:19.503643Z","steps":["trace[1859275438] 'process raft request' (duration: 717.203134ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:44:19.505712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:44:18.785351Z","time spent":"720.239333ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:44:30.02406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.476448ms","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-26T05:44:30.02417Z","caller":"traceutil/trace.go:171","msg":"trace[241950609] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2931; }","duration":"396.644723ms","start":"2026-05-26T05:44:29.627505Z","end":"2026-05-26T05:44:30.024149Z","steps":["trace[241950609] 'range keys from in-memory index tree' (duration: 396.283843ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:44:30.024219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:44:29.627484Z","time spent":"396.722005ms","remote":"127.0.0.1:53088","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-26T05:44:30.024527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.685741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-26T05:44:30.024561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.417466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-26T05:44:30.024602Z","caller":"traceutil/trace.go:171","msg":"trace[1963912085] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2931; }","duration":"403.794924ms","start":"2026-05-26T05:44:29.620786Z","end":"2026-05-26T05:44:30.024581Z","steps":["trace[1963912085] 'range keys from in-memory index tree' (duration: 403.427963ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:44:30.024619Z","caller":"traceutil/trace.go:171","msg":"trace[1294436692] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2931; }","duration":"396.484229ms","start":"2026-05-26T05:44:29.628119Z","end":"2026-05-26T05:44:30.024603Z","steps":["trace[1294436692] 'range keys from in-memory index tree' (duration: 396.201411ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:44:30.024652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:44:29.620769Z","time spent":"403.870116ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T05:44:30.024922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:44:29.628074Z","time spent":"396.590662ms","remote":"127.0.0.1:53088","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-26T05:44:30.024235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.329664ms","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-26T05:44:30.025742Z","caller":"traceutil/trace.go:171","msg":"trace[2125915798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2931; }","duration":"397.773645ms","start":"2026-05-26T05:44:29.62785Z","end":"2026-05-26T05:44:30.025624Z","steps":["trace[2125915798] 'range keys from in-memory index tree' (duration: 396.19389ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:44:30.025914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:44:29.627842Z","time spent":"397.973161ms","remote":"127.0.0.1:53088","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-26T05:45:24.062387Z","caller":"traceutil/trace.go:171","msg":"trace[914879019] transaction","detail":"{read_only:false; response_revision:3213; number_of_response:1; }","duration":"122.642729ms","start":"2026-05-26T05:45:23.939716Z","end":"2026-05-26T05:45:24.062358Z","steps":["trace[914879019] 'process raft request' (duration: 122.294301ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:45:24.062506Z","caller":"traceutil/trace.go:171","msg":"trace[1561868323] transaction","detail":"{read_only:false; response_revision:3214; number_of_response:1; }","duration":"117.707629ms","start":"2026-05-26T05:45:23.94476Z","end":"2026-05-26T05:45:24.062468Z","steps":["trace[1561868323] 'process raft request' (duration: 117.434813ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:46:24.625311Z","caller":"traceutil/trace.go:171","msg":"trace[1395159255] transaction","detail":"{read_only:false; response_revision:3621; number_of_response:1; }","duration":"100.606323ms","start":"2026-05-26T05:46:24.524677Z","end":"2026-05-26T05:46:24.625283Z","steps":["trace[1395159255] 'process raft request' (duration: 100.40101ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:46:36.464488Z","caller":"traceutil/trace.go:171","msg":"trace[1573983379] transaction","detail":"{read_only:false; response_revision:3689; number_of_response:1; }","duration":"116.467122ms","start":"2026-05-26T05:46:36.347981Z","end":"2026-05-26T05:46:36.464448Z","steps":["trace[1573983379] 'process raft request' (duration: 116.252568ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:46:36.464691Z","caller":"traceutil/trace.go:171","msg":"trace[1874323907] transaction","detail":"{read_only:false; response_revision:3690; number_of_response:1; }","duration":"116.066166ms","start":"2026-05-26T05:46:36.348601Z","end":"2026-05-26T05:46:36.464667Z","steps":["trace[1874323907] 'process raft request' (duration: 115.786011ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:48:05.568658Z","caller":"traceutil/trace.go:171","msg":"trace[1576032133] linearizableReadLoop","detail":"{readStateIndex:4778; appliedIndex:4778; }","duration":"139.046937ms","start":"2026-05-26T05:48:05.429595Z","end":"2026-05-26T05:48:05.568642Z","steps":["trace[1576032133] 'read index received' (duration: 139.036267ms)","trace[1576032133] 'applied index is now lower than readState.Index' (duration: 9.29µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:48:05.568879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.2602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-26T05:48:05.569145Z","caller":"traceutil/trace.go:171","msg":"trace[2007898159] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4596; }","duration":"139.556104ms","start":"2026-05-26T05:48:05.429541Z","end":"2026-05-26T05:48:05.569097Z","steps":["trace[2007898159] 'agreement among raft nodes before linearized reading' (duration: 139.20274ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:48:05.568553Z","caller":"traceutil/trace.go:171","msg":"trace[1181103835] transaction","detail":"{read_only:false; response_revision:4596; number_of_response:1; }","duration":"159.582388ms","start":"2026-05-26T05:48:05.408944Z","end":"2026-05-26T05:48:05.568527Z","steps":["trace[1181103835] 'process raft request' (duration: 159.366005ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:05.569315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.696437ms","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-26T05:48:05.569566Z","caller":"traceutil/trace.go:171","msg":"trace[349226758] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4596; }","duration":"140.046372ms","start":"2026-05-26T05:48:05.429507Z","end":"2026-05-26T05:48:05.569553Z","steps":["trace[349226758] 'agreement among raft nodes before linearized reading' (duration: 139.503393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:05.585606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.770143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-26T05:48:05.585726Z","caller":"traceutil/trace.go:171","msg":"trace[182471509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4597; }","duration":"151.913545ms","start":"2026-05-26T05:48:05.433779Z","end":"2026-05-26T05:48:05.585692Z","steps":["trace[182471509] 'agreement among raft nodes before linearized reading' (duration: 151.5968ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:48:08.118118Z","caller":"traceutil/trace.go:171","msg":"trace[1233552791] transaction","detail":"{read_only:false; response_revision:4632; number_of_response:1; }","duration":"193.904407ms","start":"2026-05-26T05:48:07.924188Z","end":"2026-05-26T05:48:08.118092Z","steps":["trace[1233552791] 'process raft request' (duration: 193.739564ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:10.509431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.014966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d75ec193-12fc-4a61-a9a3-7cd3142f971e\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-05-26T05:48:10.509675Z","caller":"traceutil/trace.go:171","msg":"trace[786508440] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d75ec193-12fc-4a61-a9a3-7cd3142f971e; range_end:; response_count:1; response_revision:4745; }","duration":"102.369331ms","start":"2026-05-26T05:48:10.407278Z","end":"2026-05-26T05:48:10.509647Z","steps":["trace[786508440] 'range keys from in-memory index tree' (duration: 101.709722ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:18.749022Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256879325914927737,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-26T05:48:18.821756Z","caller":"traceutil/trace.go:171","msg":"trace[361272558] transaction","detail":"{read_only:false; response_revision:4851; number_of_response:1; }","duration":"690.510959ms","start":"2026-05-26T05:48:18.131196Z","end":"2026-05-26T05:48:18.821707Z","steps":["trace[361272558] 'process raft request' (duration: 690.297376ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:18.821971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:48:18.131173Z","time spent":"690.680971ms","remote":"127.0.0.1:52982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10869,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:48:19.002426Z","caller":"traceutil/trace.go:171","msg":"trace[894889637] linearizableReadLoop","detail":"{readStateIndex:5044; appliedIndex:5042; }","duration":"753.918315ms","start":"2026-05-26T05:48:18.248475Z","end":"2026-05-26T05:48:19.002394Z","steps":["trace[894889637] 'read index received' (duration: 573.061141ms)","trace[894889637] 'applied index is now lower than readState.Index' (duration: 180.855524ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:48:19.003158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.442562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T05:48:19.003283Z","caller":"traceutil/trace.go:171","msg":"trace[327983644] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:4852; }","duration":"754.849578ms","start":"2026-05-26T05:48:18.248398Z","end":"2026-05-26T05:48:19.003248Z","steps":["trace[327983644] 'agreement among raft nodes before linearized reading' (duration: 754.407842ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:19.003363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:48:18.24836Z","time spent":"754.97578ms","remote":"127.0.0.1:52982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"info","ts":"2026-05-26T05:48:19.003461Z","caller":"traceutil/trace.go:171","msg":"trace[1095677818] transaction","detail":"{read_only:false; response_revision:4852; number_of_response:1; }","duration":"270.046539ms","start":"2026-05-26T05:48:18.733335Z","end":"2026-05-26T05:48:19.003381Z","steps":["trace[1095677818] 'process raft request' (duration: 268.878803ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:48:19.010238Z","caller":"traceutil/trace.go:171","msg":"trace[2022126791] transaction","detail":"{read_only:false; response_revision:4853; number_of_response:1; }","duration":"187.974736ms","start":"2026-05-26T05:48:18.822246Z","end":"2026-05-26T05:48:19.010221Z","steps":["trace[2022126791] 'process raft request' (duration: 187.741563ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:48:19.010551Z","caller":"traceutil/trace.go:171","msg":"trace[6754267] transaction","detail":"{read_only:false; response_revision:4854; number_of_response:1; }","duration":"182.153155ms","start":"2026-05-26T05:48:18.828382Z","end":"2026-05-26T05:48:19.010535Z","steps":["trace[6754267] 'process raft request' (duration: 181.773799ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:19.011592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"690.100242ms","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":"info","ts":"2026-05-26T05:48:19.011932Z","caller":"traceutil/trace.go:171","msg":"trace[1810833492] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4856; }","duration":"690.516779ms","start":"2026-05-26T05:48:18.321398Z","end":"2026-05-26T05:48:19.011915Z","steps":["trace[1810833492] 'agreement among raft nodes before linearized reading' (duration: 689.978941ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:19.012026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:48:18.321366Z","time spent":"690.64452ms","remote":"127.0.0.1:52958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":1876,"request content":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-05-26T05:48:19.147033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.814196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:48:19.147148Z","caller":"traceutil/trace.go:171","msg":"trace[837586747] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:4858; }","duration":"110.02718ms","start":"2026-05-26T05:48:19.037081Z","end":"2026-05-26T05:48:19.147108Z","steps":["trace[837586747] 'agreement among raft nodes before linearized reading' (duration: 54.672491ms)","trace[837586747] 'count revisions from in-memory index tree' (duration: 55.132266ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:48:19.147256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.040313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-26T05:48:19.147382Z","caller":"traceutil/trace.go:171","msg":"trace[1396845385] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4858; }","duration":"106.203006ms","start":"2026-05-26T05:48:19.041137Z","end":"2026-05-26T05:48:19.14734Z","steps":["trace[1396845385] 'agreement among raft nodes before linearized reading' (duration: 50.588943ms)","trace[1396845385] 'range keys from in-memory index tree' (duration: 55.284179ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:48:19.628999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.117823ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:48:19.629404Z","caller":"traceutil/trace.go:171","msg":"trace[94212756] linearizableReadLoop","detail":"{readStateIndex:5054; appliedIndex:5051; }","duration":"449.84446ms","start":"2026-05-26T05:48:19.179534Z","end":"2026-05-26T05:48:19.629378Z","steps":["trace[94212756] 'read index received' (duration: 233.151718ms)","trace[94212756] 'applied index is now lower than readState.Index' (duration: 216.688462ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:48:19.629472Z","caller":"traceutil/trace.go:171","msg":"trace[163532644] transaction","detail":"{read_only:false; response_revision:4862; number_of_response:1; }","duration":"469.836185ms","start":"2026-05-26T05:48:19.159594Z","end":"2026-05-26T05:48:19.62943Z","steps":["trace[163532644] 'process raft request' (duration: 469.713332ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:19.629672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.251674ms","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-26T05:48:19.629653Z","caller":"traceutil/trace.go:171","msg":"trace[691494507] transaction","detail":"{read_only:false; response_revision:4860; number_of_response:1; }","duration":"474.254457ms","start":"2026-05-26T05:48:19.155359Z","end":"2026-05-26T05:48:19.629614Z","steps":["trace[691494507] 'process raft request' (duration: 257.386603ms)","trace[691494507] 'compare' (duration: 215.763538ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:48:19.629686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:48:19.159564Z","time spent":"469.996707ms","remote":"127.0.0.1:52966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1283,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:48:19.629714Z","caller":"traceutil/trace.go:171","msg":"trace[141437703] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4862; }","duration":"370.354466ms","start":"2026-05-26T05:48:19.259349Z","end":"2026-05-26T05:48:19.629704Z","steps":["trace[141437703] 'agreement among raft nodes before linearized reading' (duration: 370.165783ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:19.629651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.096223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:48:19.629836Z","caller":"traceutil/trace.go:171","msg":"trace[737398303] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:4862; }","duration":"450.336536ms","start":"2026-05-26T05:48:19.179474Z","end":"2026-05-26T05:48:19.62981Z","steps":["trace[737398303] 'agreement among raft nodes before linearized reading' (duration: 450.029352ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:19.629824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:48:19.155338Z","time spent":"474.39445ms","remote":"127.0.0.1:52966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":906,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:48:19.629978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:48:19.179459Z","time spent":"450.503649ms","remote":"127.0.0.1:60734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true "} {"level":"warn","ts":"2026-05-26T05:48:19.629757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:48:19.259316Z","time spent":"370.431726ms","remote":"127.0.0.1:53088","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-26T05:48:19.630228Z","caller":"traceutil/trace.go:171","msg":"trace[1211218773] transaction","detail":"{read_only:false; response_revision:4861; number_of_response:1; }","duration":"471.61149ms","start":"2026-05-26T05:48:19.157813Z","end":"2026-05-26T05:48:19.629425Z","steps":["trace[1211218773] 'process raft request' (duration: 471.357555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:19.632157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:48:19.157804Z","time spent":"473.449546ms","remote":"127.0.0.1:53100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1455,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:48:19.792289Z","caller":"traceutil/trace.go:171","msg":"trace[403428297] linearizableReadLoop","detail":"{readStateIndex:5057; appliedIndex:5056; }","duration":"105.734879ms","start":"2026-05-26T05:48:19.686522Z","end":"2026-05-26T05:48:19.792257Z","steps":["trace[403428297] 'read index received' (duration: 53.860319ms)","trace[403428297] 'applied index is now lower than readState.Index' (duration: 51.8731ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:48:19.792566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.779118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:48:19.792656Z","caller":"traceutil/trace.go:171","msg":"trace[645301328] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:4866; }","duration":"100.92896ms","start":"2026-05-26T05:48:19.691709Z","end":"2026-05-26T05:48:19.792638Z","steps":["trace[645301328] 'agreement among raft nodes before linearized reading' (duration: 100.764798ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:19.792689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.686634ms","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-26T05:48:19.792712Z","caller":"traceutil/trace.go:171","msg":"trace[316862664] transaction","detail":"{read_only:false; response_revision:4866; number_of_response:1; }","duration":"101.144903ms","start":"2026-05-26T05:48:19.691494Z","end":"2026-05-26T05:48:19.792639Z","steps":["trace[316862664] 'process raft request' (duration: 100.721467ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:48:19.792744Z","caller":"traceutil/trace.go:171","msg":"trace[1831395074] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4866; }","duration":"116.782545ms","start":"2026-05-26T05:48:19.675946Z","end":"2026-05-26T05:48:19.792729Z","steps":["trace[1831395074] 'agreement among raft nodes before linearized reading' (duration: 116.423151ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:48:19.793102Z","caller":"traceutil/trace.go:171","msg":"trace[370921279] transaction","detail":"{read_only:false; response_revision:4865; number_of_response:1; }","duration":"116.430871ms","start":"2026-05-26T05:48:19.675886Z","end":"2026-05-26T05:48:19.792317Z","steps":["trace[370921279] 'process raft request' (duration: 64.52113ms)","trace[370921279] 'compare' (duration: 51.623807ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:48:19.793453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.482394ms","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-26T05:48:19.793826Z","caller":"traceutil/trace.go:171","msg":"trace[981373252] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:4866; }","duration":"100.863689ms","start":"2026-05-26T05:48:19.692948Z","end":"2026-05-26T05:48:19.793812Z","steps":["trace[981373252] 'agreement among raft nodes before linearized reading' (duration: 99.857334ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:26.777936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.060533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cfeb0c2e-7a66-4629-9268-05528b97a258\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-26T05:48:26.778043Z","caller":"traceutil/trace.go:171","msg":"trace[2144975863] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cfeb0c2e-7a66-4629-9268-05528b97a258; range_end:; response_count:1; response_revision:5021; }","duration":"158.235725ms","start":"2026-05-26T05:48:26.619785Z","end":"2026-05-26T05:48:26.778021Z","steps":["trace[2144975863] 'range keys from in-memory index tree' (duration: 157.906031ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:26.778027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.161271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-05-26T05:48:26.778138Z","caller":"traceutil/trace.go:171","msg":"trace[1101764419] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5021; }","duration":"264.329813ms","start":"2026-05-26T05:48:26.513783Z","end":"2026-05-26T05:48:26.778113Z","steps":["trace[1101764419] 'range keys from in-memory index tree' (duration: 263.957199ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:27.562221Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256879325914928134,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-26T05:48:27.703205Z","caller":"traceutil/trace.go:171","msg":"trace[1212510742] transaction","detail":"{read_only:false; response_revision:5022; number_of_response:1; }","duration":"662.561045ms","start":"2026-05-26T05:48:27.040618Z","end":"2026-05-26T05:48:27.703179Z","steps":["trace[1212510742] 'process raft request' (duration: 662.394363ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:27.703838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:48:27.040585Z","time spent":"662.685738ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:48:27.750912Z","caller":"traceutil/trace.go:171","msg":"trace[506485000] linearizableReadLoop","detail":"{readStateIndex:5222; appliedIndex:5217; }","duration":"688.758105ms","start":"2026-05-26T05:48:27.062132Z","end":"2026-05-26T05:48:27.750891Z","steps":["trace[506485000] 'read index received' (duration: 640.960821ms)","trace[506485000] 'applied index is now lower than readState.Index' (duration: 47.796354ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:48:27.751189Z","caller":"traceutil/trace.go:171","msg":"trace[1457625021] transaction","detail":"{read_only:false; response_revision:5026; number_of_response:1; }","duration":"312.200393ms","start":"2026-05-26T05:48:27.438932Z","end":"2026-05-26T05:48:27.751132Z","steps":["trace[1457625021] 'process raft request' (duration: 311.92421ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:27.751276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.126821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-6sls9\" ","response":"range_response_count:1 size:9942"} {"level":"info","ts":"2026-05-26T05:48:27.751312Z","caller":"traceutil/trace.go:171","msg":"trace[196392158] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-6sls9; range_end:; response_count:1; response_revision:5026; }","duration":"689.221592ms","start":"2026-05-26T05:48:27.062079Z","end":"2026-05-26T05:48:27.751301Z","steps":["trace[196392158] 'agreement among raft nodes before linearized reading' (duration: 689.08888ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:27.751342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:48:27.062058Z","time spent":"689.277202ms","remote":"127.0.0.1:52998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":9965,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-6sls9\" "} {"level":"warn","ts":"2026-05-26T05:48:27.751407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:48:27.438899Z","time spent":"312.383516ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:48:27.751567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.321178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-26T05:48:27.751602Z","caller":"traceutil/trace.go:171","msg":"trace[503936510] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5026; }","duration":"583.39395ms","start":"2026-05-26T05:48:27.168197Z","end":"2026-05-26T05:48:27.751591Z","steps":["trace[503936510] 'agreement among raft nodes before linearized reading' (duration: 583.306378ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:27.751621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:48:27.168179Z","time spent":"583.43823ms","remote":"127.0.0.1:52958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1958,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"info","ts":"2026-05-26T05:48:27.751699Z","caller":"traceutil/trace.go:171","msg":"trace[170351448] transaction","detail":"{read_only:false; response_revision:5025; number_of_response:1; }","duration":"705.419981ms","start":"2026-05-26T05:48:27.046266Z","end":"2026-05-26T05:48:27.751686Z","steps":["trace[170351448] 'process raft request' (duration: 704.564178ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:27.751764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:48:27.046254Z","time spent":"705.476872ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:48:27.75189Z","caller":"traceutil/trace.go:171","msg":"trace[2134438998] transaction","detail":"{read_only:false; response_revision:5024; number_of_response:1; }","duration":"706.930382ms","start":"2026-05-26T05:48:27.044863Z","end":"2026-05-26T05:48:27.751794Z","steps":["trace[2134438998] 'process raft request' (duration: 705.932588ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:48:27.752196Z","caller":"traceutil/trace.go:171","msg":"trace[742800124] transaction","detail":"{read_only:false; response_revision:5023; number_of_response:1; }","duration":"711.226383ms","start":"2026-05-26T05:48:27.040957Z","end":"2026-05-26T05:48:27.752184Z","steps":["trace[742800124] 'process raft request' (duration: 709.700621ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:27.752284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:48:27.040906Z","time spent":"711.324033ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:48:27.752458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:48:27.04483Z","time spent":"707.331387ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:48:27.934787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.907896ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:48:27.935216Z","caller":"traceutil/trace.go:171","msg":"trace[1960982319] transaction","detail":"{read_only:false; response_revision:5027; number_of_response:1; }","duration":"176.677083ms","start":"2026-05-26T05:48:27.758223Z","end":"2026-05-26T05:48:27.9349Z","steps":["trace[1960982319] 'process raft request' (duration: 28.525193ms)","trace[1960982319] 'compare' (duration: 147.755364ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:48:27.935906Z","caller":"traceutil/trace.go:171","msg":"trace[272176336] transaction","detail":"{read_only:false; response_revision:5029; number_of_response:1; }","duration":"172.27053ms","start":"2026-05-26T05:48:27.763618Z","end":"2026-05-26T05:48:27.935888Z","steps":["trace[272176336] 'process raft request' (duration: 172.046847ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:48:27.93593Z","caller":"traceutil/trace.go:171","msg":"trace[2028423676] linearizableReadLoop","detail":"{readStateIndex:5224; appliedIndex:5222; }","duration":"176.431379ms","start":"2026-05-26T05:48:27.759451Z","end":"2026-05-26T05:48:27.935882Z","steps":["trace[2028423676] 'read index received' (duration: 27.310926ms)","trace[2028423676] 'applied index is now lower than readState.Index' (duration: 149.117863ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:48:27.936245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.763333ms","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-26T05:48:27.936319Z","caller":"traceutil/trace.go:171","msg":"trace[813838888] 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:5029; }","duration":"176.873215ms","start":"2026-05-26T05:48:27.759425Z","end":"2026-05-26T05:48:27.936298Z","steps":["trace[813838888] 'agreement among raft nodes before linearized reading' (duration: 176.552081ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:27.936558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.924481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cfeb0c2e-7a66-4629-9268-05528b97a258\" ","response":"range_response_count:1 size:3646"} {"level":"warn","ts":"2026-05-26T05:48:27.936658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.362164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-26T05:48:27.936699Z","caller":"traceutil/trace.go:171","msg":"trace[701018687] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5029; }","duration":"102.423454ms","start":"2026-05-26T05:48:27.834264Z","end":"2026-05-26T05:48:27.936687Z","steps":["trace[701018687] 'agreement among raft nodes before linearized reading' (duration: 102.304423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:27.936704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.462099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T05:48:27.936882Z","caller":"traceutil/trace.go:171","msg":"trace[1498088009] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:5029; }","duration":"115.687562ms","start":"2026-05-26T05:48:27.82117Z","end":"2026-05-26T05:48:27.936858Z","steps":["trace[1498088009] 'agreement among raft nodes before linearized reading' (duration: 115.415198ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:48:27.936642Z","caller":"traceutil/trace.go:171","msg":"trace[1757325201] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cfeb0c2e-7a66-4629-9268-05528b97a258; range_end:; response_count:1; response_revision:5029; }","duration":"154.074574ms","start":"2026-05-26T05:48:27.782551Z","end":"2026-05-26T05:48:27.936625Z","steps":["trace[1757325201] 'agreement among raft nodes before linearized reading' (duration: 153.754078ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:48:27.935793Z","caller":"traceutil/trace.go:171","msg":"trace[592073420] transaction","detail":"{read_only:false; response_revision:5028; number_of_response:1; }","duration":"177.2621ms","start":"2026-05-26T05:48:27.758494Z","end":"2026-05-26T05:48:27.935756Z","steps":["trace[592073420] 'process raft request' (duration: 177.012947ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:34.129024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.595982ms","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-26T05:48:34.129154Z","caller":"traceutil/trace.go:171","msg":"trace[68237315] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5094; }","duration":"162.751026ms","start":"2026-05-26T05:48:33.966348Z","end":"2026-05-26T05:48:34.129099Z","steps":["trace[68237315] 'range keys from in-memory index tree' (duration: 162.363489ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:34.129197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.836258ms","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-26T05:48:34.129286Z","caller":"traceutil/trace.go:171","msg":"trace[210312967] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5094; }","duration":"160.95836ms","start":"2026-05-26T05:48:33.968305Z","end":"2026-05-26T05:48:34.129264Z","steps":["trace[210312967] 'range keys from in-memory index tree' (duration: 160.613704ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:34.12934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.156313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-26T05:48:34.129397Z","caller":"traceutil/trace.go:171","msg":"trace[122472088] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5094; }","duration":"151.239814ms","start":"2026-05-26T05:48:33.978143Z","end":"2026-05-26T05:48:34.129383Z","steps":["trace[122472088] 'range keys from in-memory index tree' (duration: 151.020701ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:34.129339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.245301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-26T05:48:34.129519Z","caller":"traceutil/trace.go:171","msg":"trace[1364978615] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5094; }","duration":"148.491695ms","start":"2026-05-26T05:48:33.981006Z","end":"2026-05-26T05:48:34.129498Z","steps":["trace[1364978615] 'range keys from in-memory index tree' (duration: 148.003949ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:34.129613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.04747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-6d577b54c9-vlshd\" ","response":"range_response_count:1 size:11845"} {"level":"warn","ts":"2026-05-26T05:48:34.129627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.740685ms","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-26T05:48:34.129654Z","caller":"traceutil/trace.go:171","msg":"trace[1284345537] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-6d577b54c9-vlshd; range_end:; response_count:1; response_revision:5094; }","duration":"206.130781ms","start":"2026-05-26T05:48:33.923504Z","end":"2026-05-26T05:48:34.129635Z","steps":["trace[1284345537] 'range keys from in-memory index tree' (duration: 205.941639ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:48:34.129666Z","caller":"traceutil/trace.go:171","msg":"trace[412180862] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5094; }","duration":"147.789586ms","start":"2026-05-26T05:48:33.981863Z","end":"2026-05-26T05:48:34.129653Z","steps":["trace[412180862] 'range keys from in-memory index tree' (duration: 147.618904ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:49:11.396542Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2838} {"level":"info","ts":"2026-05-26T05:49:11.483553Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2838,"took":"85.464172ms","hash":855359056,"current-db-size-bytes":52170752,"current-db-size":"52 MB","current-db-size-in-use-bytes":28438528,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-26T05:49:11.483634Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":855359056,"revision":2838,"compact-revision":-1} {"level":"info","ts":"2026-05-26T05:49:19.987472Z","caller":"traceutil/trace.go:171","msg":"trace[1617360124] transaction","detail":"{read_only:false; response_revision:5465; number_of_response:1; }","duration":"226.229419ms","start":"2026-05-26T05:49:19.761196Z","end":"2026-05-26T05:49:19.987426Z","steps":["trace[1617360124] 'process raft request' (duration: 151.041982ms)","trace[1617360124] 'compare' (duration: 74.913193ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:49:19.987446Z","caller":"traceutil/trace.go:171","msg":"trace[1335413350] linearizableReadLoop","detail":"{readStateIndex:5674; appliedIndex:5673; }","duration":"183.998349ms","start":"2026-05-26T05:49:19.80336Z","end":"2026-05-26T05:49:19.987359Z","steps":["trace[1335413350] 'read index received' (duration: 108.779772ms)","trace[1335413350] 'applied index is now lower than readState.Index' (duration: 75.217117ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:49:19.988848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.45371ms","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-26T05:49:19.989295Z","caller":"traceutil/trace.go:171","msg":"trace[1374872533] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5465; }","duration":"185.988115ms","start":"2026-05-26T05:49:19.803277Z","end":"2026-05-26T05:49:19.989265Z","steps":["trace[1374872533] 'agreement among raft nodes before linearized reading' (duration: 184.227612ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:19.989594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.544766ms","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-26T05:49:19.989711Z","caller":"traceutil/trace.go:171","msg":"trace[1777526283] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5465; }","duration":"141.725569ms","start":"2026-05-26T05:49:19.847956Z","end":"2026-05-26T05:49:19.989682Z","steps":["trace[1777526283] 'agreement among raft nodes before linearized reading' (duration: 141.294193ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:20.234375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.992077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:49:20.234489Z","caller":"traceutil/trace.go:171","msg":"trace[1377446391] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:5470; }","duration":"147.147079ms","start":"2026-05-26T05:49:20.087315Z","end":"2026-05-26T05:49:20.234462Z","steps":["trace[1377446391] 'range keys from in-memory index tree' (duration: 146.919626ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:20.64224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.202508ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:49:20.64262Z","caller":"traceutil/trace.go:171","msg":"trace[1247170358] transaction","detail":"{read_only:false; response_revision:5475; number_of_response:1; }","duration":"187.194759ms","start":"2026-05-26T05:49:20.455399Z","end":"2026-05-26T05:49:20.642594Z","steps":["trace[1247170358] 'process raft request' (duration: 186.989447ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:49:20.64263Z","caller":"traceutil/trace.go:171","msg":"trace[1983828570] transaction","detail":"{read_only:false; response_revision:5474; number_of_response:1; }","duration":"187.191779ms","start":"2026-05-26T05:49:20.455371Z","end":"2026-05-26T05:49:20.642563Z","steps":["trace[1983828570] 'process raft request' (duration: 55.525425ms)","trace[1983828570] 'compare' (duration: 130.928874ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:49:20.682146Z","caller":"traceutil/trace.go:171","msg":"trace[1959356402] transaction","detail":"{read_only:false; response_revision:5476; number_of_response:1; }","duration":"226.651892ms","start":"2026-05-26T05:49:20.455467Z","end":"2026-05-26T05:49:20.682119Z","steps":["trace[1959356402] 'process raft request' (duration: 226.49691ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:19.540318Z","caller":"traceutil/trace.go:171","msg":"trace[1228651455] transaction","detail":"{read_only:false; response_revision:6720; number_of_response:1; }","duration":"100.995431ms","start":"2026-05-26T05:52:19.439298Z","end":"2026-05-26T05:52:19.540293Z","steps":["trace[1228651455] 'process raft request' (duration: 100.91851ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:20.995881Z","caller":"traceutil/trace.go:171","msg":"trace[1407579877] transaction","detail":"{read_only:false; response_revision:6725; number_of_response:1; }","duration":"164.436451ms","start":"2026-05-26T05:52:20.831423Z","end":"2026-05-26T05:52:20.99586Z","steps":["trace[1407579877] 'process raft request' (duration: 164.298129ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:20.996541Z","caller":"traceutil/trace.go:171","msg":"trace[1366080627] transaction","detail":"{read_only:false; response_revision:6726; number_of_response:1; }","duration":"130.696125ms","start":"2026-05-26T05:52:20.865821Z","end":"2026-05-26T05:52:20.996517Z","steps":["trace[1366080627] 'process raft request' (duration: 130.515803ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:20.996838Z","caller":"traceutil/trace.go:171","msg":"trace[45369887] transaction","detail":"{read_only:false; response_revision:6727; number_of_response:1; }","duration":"129.830995ms","start":"2026-05-26T05:52:20.866985Z","end":"2026-05-26T05:52:20.996816Z","steps":["trace[45369887] 'process raft request' (duration: 129.492411ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:20.996938Z","caller":"traceutil/trace.go:171","msg":"trace[1704980816] transaction","detail":"{read_only:false; response_revision:6728; number_of_response:1; }","duration":"128.246017ms","start":"2026-05-26T05:52:20.868651Z","end":"2026-05-26T05:52:20.996897Z","steps":["trace[1704980816] 'process raft request' (duration: 128.003383ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:20.997433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.811548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-05-26T05:52:20.997506Z","caller":"traceutil/trace.go:171","msg":"trace[914850841] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:6729; }","duration":"105.927019ms","start":"2026-05-26T05:52:20.891561Z","end":"2026-05-26T05:52:20.997488Z","steps":["trace[914850841] 'agreement among raft nodes before linearized reading' (duration: 105.703777ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:20.996851Z","caller":"traceutil/trace.go:171","msg":"trace[972591242] linearizableReadLoop","detail":"{readStateIndex:6979; appliedIndex:6975; }","duration":"105.231912ms","start":"2026-05-26T05:52:20.891605Z","end":"2026-05-26T05:52:20.996837Z","steps":["trace[972591242] 'read index received' (duration: 104.019417ms)","trace[972591242] 'applied index is now lower than readState.Index' (duration: 1.211705ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:52:39.779696Z","caller":"traceutil/trace.go:171","msg":"trace[460195337] transaction","detail":"{read_only:false; response_revision:6878; number_of_response:1; }","duration":"139.081789ms","start":"2026-05-26T05:52:39.640591Z","end":"2026-05-26T05:52:39.779673Z","steps":["trace[460195337] 'process raft request' (duration: 138.693318ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:51.514001Z","caller":"traceutil/trace.go:171","msg":"trace[1178309898] transaction","detail":"{read_only:false; response_revision:6935; number_of_response:1; }","duration":"225.778912ms","start":"2026-05-26T05:52:51.287978Z","end":"2026-05-26T05:52:51.513757Z","steps":["trace[1178309898] 'process raft request' (duration: 225.594927ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:51.532574Z","caller":"traceutil/trace.go:171","msg":"trace[309073026] transaction","detail":"{read_only:false; response_revision:6936; number_of_response:1; }","duration":"242.308785ms","start":"2026-05-26T05:52:51.290243Z","end":"2026-05-26T05:52:51.532552Z","steps":["trace[309073026] 'process raft request' (duration: 242.095759ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:51.532568Z","caller":"traceutil/trace.go:171","msg":"trace[1583014093] transaction","detail":"{read_only:false; response_revision:6937; number_of_response:1; }","duration":"241.581146ms","start":"2026-05-26T05:52:51.290961Z","end":"2026-05-26T05:52:51.532542Z","steps":["trace[1583014093] 'process raft request' (duration: 241.522135ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:57.666845Z","caller":"traceutil/trace.go:171","msg":"trace[1718757038] transaction","detail":"{read_only:false; response_revision:6969; number_of_response:1; }","duration":"114.105524ms","start":"2026-05-26T05:52:57.552704Z","end":"2026-05-26T05:52:57.66681Z","steps":["trace[1718757038] 'process raft request' (duration: 113.896709ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:53:28.421344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.716367ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:53:28.421504Z","caller":"traceutil/trace.go:171","msg":"trace[1186702088] linearizableReadLoop","detail":"{readStateIndex:7417; appliedIndex:7415; }","duration":"233.741752ms","start":"2026-05-26T05:53:28.187746Z","end":"2026-05-26T05:53:28.421488Z","steps":["trace[1186702088] 'read index received' (duration: 116.8008ms)","trace[1186702088] 'applied index is now lower than readState.Index' (duration: 116.939612ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:53:28.421568Z","caller":"traceutil/trace.go:171","msg":"trace[1715767161] transaction","detail":"{read_only:false; response_revision:7148; number_of_response:1; }","duration":"240.554894ms","start":"2026-05-26T05:53:28.180989Z","end":"2026-05-26T05:53:28.421544Z","steps":["trace[1715767161] 'process raft request' (duration: 123.55557ms)","trace[1715767161] 'compare' (duration: 116.610864ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:53:28.421594Z","caller":"traceutil/trace.go:171","msg":"trace[260513236] transaction","detail":"{read_only:false; response_revision:7149; number_of_response:1; }","duration":"239.006135ms","start":"2026-05-26T05:53:28.18258Z","end":"2026-05-26T05:53:28.421586Z","steps":["trace[260513236] 'process raft request' (duration: 238.858301ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:53:28.421874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.104831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/monitoring/kube-prometheus-stack-alertmanager-oauth2-proxy\" ","response":"range_response_count:1 size:2890"} {"level":"info","ts":"2026-05-26T05:53:28.421962Z","caller":"traceutil/trace.go:171","msg":"trace[562201183] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/monitoring/kube-prometheus-stack-alertmanager-oauth2-proxy; range_end:; response_count:1; response_revision:7149; }","duration":"234.213604ms","start":"2026-05-26T05:53:28.187729Z","end":"2026-05-26T05:53:28.421942Z","steps":["trace[562201183] 'agreement among raft nodes before linearized reading' (duration: 233.964578ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:53:28.422438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.61966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-26T05:53:28.422584Z","caller":"traceutil/trace.go:171","msg":"trace[1331587571] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7149; }","duration":"215.801654ms","start":"2026-05-26T05:53:28.206761Z","end":"2026-05-26T05:53:28.422563Z","steps":["trace[1331587571] 'agreement among raft nodes before linearized reading' (duration: 215.494987ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:53:52.074925Z","caller":"traceutil/trace.go:171","msg":"trace[1026125421] transaction","detail":"{read_only:false; response_revision:7266; number_of_response:1; }","duration":"131.593645ms","start":"2026-05-26T05:53:51.943307Z","end":"2026-05-26T05:53:52.074901Z","steps":["trace[1026125421] 'process raft request' (duration: 87.56793ms)","trace[1026125421] 'compare' (duration: 43.897792ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:53:52.07524Z","caller":"traceutil/trace.go:171","msg":"trace[1991200729] transaction","detail":"{read_only:false; response_revision:7267; number_of_response:1; }","duration":"128.632214ms","start":"2026-05-26T05:53:51.946435Z","end":"2026-05-26T05:53:52.075067Z","steps":["trace[1991200729] 'process raft request' (duration: 128.428069ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:53:52.670916Z","caller":"traceutil/trace.go:171","msg":"trace[1120923724] transaction","detail":"{read_only:false; response_revision:7270; number_of_response:1; }","duration":"123.13129ms","start":"2026-05-26T05:53:52.547764Z","end":"2026-05-26T05:53:52.670895Z","steps":["trace[1120923724] 'process raft request' (duration: 123.012437ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:53:52.672909Z","caller":"traceutil/trace.go:171","msg":"trace[1791886659] transaction","detail":"{read_only:false; response_revision:7271; number_of_response:1; }","duration":"123.871798ms","start":"2026-05-26T05:53:52.549015Z","end":"2026-05-26T05:53:52.672887Z","steps":["trace[1791886659] 'process raft request' (duration: 123.718914ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:54:11.402637Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5418} {"level":"info","ts":"2026-05-26T05:54:11.530333Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5418,"took":"126.33177ms","hash":3473888511,"current-db-size-bytes":52170752,"current-db-size":"52 MB","current-db-size-in-use-bytes":18718720,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-05-26T05:54:11.530407Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3473888511,"revision":5418,"compact-revision":2838} {"level":"info","ts":"2026-05-26T05:55:48.590121Z","caller":"traceutil/trace.go:171","msg":"trace[1028572084] transaction","detail":"{read_only:false; response_revision:7855; number_of_response:1; }","duration":"116.526133ms","start":"2026-05-26T05:55:48.473543Z","end":"2026-05-26T05:55:48.590069Z","steps":["trace[1028572084] 'process raft request' (duration: 88.251224ms)","trace[1028572084] 'compare' (duration: 27.435072ms)"],"step_count":2}