{"level":"warn","ts":"2026-06-09T16:44:12.469065Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T16:44:12.469229Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.223: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.223:2380","--initial-cluster=instance=https://199.204.45.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.223: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-06-09T16:44:12.46934Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T16:44:12.469363Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-06-09T16:44:12.469394Z","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-06-09T16:44:12.470886Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"]} {"level":"info","ts":"2026-06-09T16:44:12.471035Z","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.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.223: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-06-09T16:44:12.476615Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.161564ms"} {"level":"info","ts":"2026-06-09T16:44:12.482725Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11f26225a5bb9fe3","cluster-id":"75c25101f01fd4c6"} {"level":"info","ts":"2026-06-09T16:44:12.48281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=()"} {"level":"info","ts":"2026-06-09T16:44:12.482828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 0"} {"level":"info","ts":"2026-06-09T16:44:12.482845Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 11f26225a5bb9fe3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-09T16:44:12.482855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 1"} {"level":"info","ts":"2026-06-09T16:44:12.482896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"warn","ts":"2026-06-09T16:44:12.490803Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-09T16:44:12.492373Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-09T16:44:12.493524Z","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-06-09T16:44:12.496697Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"11f26225a5bb9fe3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-09T16:44:12.497042Z","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-06-09T16:44:12.497217Z","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-06-09T16:44:12.497262Z","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-06-09T16:44:12.497534Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"11f26225a5bb9fe3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-09T16:44:12.498564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"info","ts":"2026-06-09T16:44:12.498863Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","added-peer-id":"11f26225a5bb9fe3","added-peer-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-06-09T16:44:12.501784Z","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-06-09T16:44:12.501914Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-06-09T16:44:12.50205Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-06-09T16:44:12.50249Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"11f26225a5bb9fe3","initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-09T16:44:12.50257Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-09T16:44:13.28395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 is starting a new election at term 1"} {"level":"info","ts":"2026-06-09T16:44:13.284001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-09T16:44:13.284026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgPreVoteResp from 11f26225a5bb9fe3 at term 1"} {"level":"info","ts":"2026-06-09T16:44:13.284038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became candidate at term 2"} {"level":"info","ts":"2026-06-09T16:44:13.284044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgVoteResp from 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-06-09T16:44:13.284054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became leader at term 2"} {"level":"info","ts":"2026-06-09T16:44:13.284062Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11f26225a5bb9fe3 elected leader 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-06-09T16:44:13.325348Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"11f26225a5bb9fe3","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.223:2379]}","request-path":"/0/members/11f26225a5bb9fe3/attributes","cluster-id":"75c25101f01fd4c6","publish-timeout":"7s"} {"level":"info","ts":"2026-06-09T16:44:13.329424Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T16:44:13.329427Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T16:44:13.330059Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T16:44:13.330135Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T16:44:13.330139Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T16:44:13.330158Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T16:44:13.330227Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-09T16:44:13.33024Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-09T16:44:13.332591Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.223:2379"} {"level":"info","ts":"2026-06-09T16:44:13.334457Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-09T16:44:27.137586Z","caller":"traceutil/trace.go:171","msg":"trace[1868149759] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"147.754012ms","start":"2026-06-09T16:44:26.989802Z","end":"2026-06-09T16:44:27.137556Z","steps":["trace[1868149759] 'process raft request' (duration: 147.564586ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:45:07.074745Z","caller":"traceutil/trace.go:171","msg":"trace[1234261410] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"262.840178ms","start":"2026-06-09T16:45:06.811864Z","end":"2026-06-09T16:45:07.074704Z","steps":["trace[1234261410] 'process raft request' (duration: 262.646269ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:45:07.082412Z","caller":"traceutil/trace.go:171","msg":"trace[869033718] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"252.441514ms","start":"2026-06-09T16:45:06.82994Z","end":"2026-06-09T16:45:07.082382Z","steps":["trace[869033718] 'process raft request' (duration: 252.256716ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:45:07.082681Z","caller":"traceutil/trace.go:171","msg":"trace[1696507472] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"228.385008ms","start":"2026-06-09T16:45:06.854273Z","end":"2026-06-09T16:45:07.082658Z","steps":["trace[1696507472] 'process raft request' (duration: 228.049644ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:45:07.082798Z","caller":"traceutil/trace.go:171","msg":"trace[251121283] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"234.803137ms","start":"2026-06-09T16:45:06.847985Z","end":"2026-06-09T16:45:07.082788Z","steps":["trace[251121283] 'process raft request' (duration: 234.287045ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:45:07.082937Z","caller":"traceutil/trace.go:171","msg":"trace[701488507] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"223.3996ms","start":"2026-06-09T16:45:06.859525Z","end":"2026-06-09T16:45:07.082925Z","steps":["trace[701488507] 'process raft request' (duration: 222.866167ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:45:07.082943Z","caller":"traceutil/trace.go:171","msg":"trace[1715939372] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"217.417114ms","start":"2026-06-09T16:45:06.865469Z","end":"2026-06-09T16:45:07.082886Z","steps":["trace[1715939372] 'process raft request' (duration: 216.987241ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:45:07.083016Z","caller":"traceutil/trace.go:171","msg":"trace[2764337] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"217.497782ms","start":"2026-06-09T16:45:06.865507Z","end":"2026-06-09T16:45:07.083005Z","steps":["trace[2764337] 'process raft request' (duration: 217.120105ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:45:07.083114Z","caller":"traceutil/trace.go:171","msg":"trace[2132451816] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"216.826226ms","start":"2026-06-09T16:45:06.866278Z","end":"2026-06-09T16:45:07.083105Z","steps":["trace[2132451816] 'process raft request' (duration: 216.439587ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:45:07.083212Z","caller":"traceutil/trace.go:171","msg":"trace[100578550] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"205.655023ms","start":"2026-06-09T16:45:06.877542Z","end":"2026-06-09T16:45:07.083197Z","steps":["trace[100578550] 'process raft request' (duration: 205.279135ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:45:07.083311Z","caller":"traceutil/trace.go:171","msg":"trace[1522724411] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"200.621243ms","start":"2026-06-09T16:45:06.882678Z","end":"2026-06-09T16:45:07.083299Z","steps":["trace[1522724411] 'process raft request' (duration: 200.30338ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:45:07.08352Z","caller":"traceutil/trace.go:171","msg":"trace[1228729958] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"180.834461ms","start":"2026-06-09T16:45:06.90267Z","end":"2026-06-09T16:45:07.083504Z","steps":["trace[1228729958] 'process raft request' (duration: 180.475425ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:45:07.083517Z","caller":"traceutil/trace.go:171","msg":"trace[1206784520] linearizableReadLoop","detail":"{readStateIndex:563; appliedIndex:553; }","duration":"127.01922ms","start":"2026-06-09T16:45:06.956458Z","end":"2026-06-09T16:45:07.083477Z","steps":["trace[1206784520] 'read index received' (duration: 118.30362ms)","trace[1206784520] 'applied index is now lower than readState.Index' (duration: 8.71461ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T16:45:07.083777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.283206ms","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-06-09T16:45:07.083855Z","caller":"traceutil/trace.go:171","msg":"trace[1309892656] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:538; }","duration":"127.437332ms","start":"2026-06-09T16:45:06.956407Z","end":"2026-06-09T16:45:07.083845Z","steps":["trace[1309892656] 'agreement among raft nodes before linearized reading' (duration: 127.139273ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:45:09.707331Z","caller":"traceutil/trace.go:171","msg":"trace[468295468] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"245.533082ms","start":"2026-06-09T16:45:09.461765Z","end":"2026-06-09T16:45:09.707298Z","steps":["trace[468295468] 'read index received' (duration: 230.894355ms)","trace[468295468] 'applied index is now lower than readState.Index' (duration: 14.637587ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T16:45:09.707396Z","caller":"traceutil/trace.go:171","msg":"trace[1616493551] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"352.734093ms","start":"2026-06-09T16:45:09.354624Z","end":"2026-06-09T16:45:09.707358Z","steps":["trace[1616493551] 'process raft request' (duration: 338.115049ms)","trace[1616493551] 'compare' (duration: 14.207583ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T16:45:09.707616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.832362ms","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-06-09T16:45:09.707669Z","caller":"traceutil/trace.go:171","msg":"trace[678475039] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:607; }","duration":"246.126491ms","start":"2026-06-09T16:45:09.461529Z","end":"2026-06-09T16:45:09.707655Z","steps":["trace[678475039] 'agreement among raft nodes before linearized reading' (duration: 245.931772ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:45:09.707726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.951746ms","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-06-09T16:45:09.707811Z","caller":"traceutil/trace.go:171","msg":"trace[918363667] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:607; }","duration":"104.088239ms","start":"2026-06-09T16:45:09.6037Z","end":"2026-06-09T16:45:09.707788Z","steps":["trace[918363667] 'agreement among raft nodes before linearized reading' (duration: 103.865067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:45:09.70819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:45:09.354584Z","time spent":"352.887038ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T16:45:13.324325Z","caller":"traceutil/trace.go:171","msg":"trace[2139121243] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"101.051124ms","start":"2026-06-09T16:45:13.223215Z","end":"2026-06-09T16:45:13.324267Z","steps":["trace[2139121243] 'process raft request' (duration: 100.741833ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:45:13.503617Z","caller":"traceutil/trace.go:171","msg":"trace[473391054] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"217.332107ms","start":"2026-06-09T16:45:13.286248Z","end":"2026-06-09T16:45:13.50358Z","steps":["trace[473391054] 'process raft request' (duration: 216.162119ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:45:13.63739Z","caller":"traceutil/trace.go:171","msg":"trace[1932440119] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"309.113386ms","start":"2026-06-09T16:45:13.328229Z","end":"2026-06-09T16:45:13.637342Z","steps":["trace[1932440119] 'process raft request' (duration: 281.733494ms)","trace[1932440119] 'compare' (duration: 27.06434ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T16:45:13.637645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:45:13.328204Z","time spent":"309.313696ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T16:45:14.49471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.219371ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T16:45:14.494893Z","caller":"traceutil/trace.go:171","msg":"trace[1550106954] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"761.496615ms","start":"2026-06-09T16:45:13.733349Z","end":"2026-06-09T16:45:14.494846Z","steps":["trace[1550106954] 'process raft request' (duration: 456.93379ms)","trace[1550106954] 'compare' (duration: 304.01469ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T16:45:14.494943Z","caller":"traceutil/trace.go:171","msg":"trace[1033807519] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:667; }","duration":"759.123606ms","start":"2026-06-09T16:45:13.735799Z","end":"2026-06-09T16:45:14.494922Z","steps":["trace[1033807519] 'read index received' (duration: 454.587233ms)","trace[1033807519] 'applied index is now lower than readState.Index' (duration: 304.534073ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T16:45:14.495097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.304474ms","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-06-09T16:45:14.495124Z","caller":"traceutil/trace.go:171","msg":"trace[994723112] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:636; }","duration":"759.352339ms","start":"2026-06-09T16:45:13.735765Z","end":"2026-06-09T16:45:14.495117Z","steps":["trace[994723112] 'agreement among raft nodes before linearized reading' (duration: 759.243238ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:45:14.495152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:45:13.735754Z","time spent":"759.392512ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-09T16:45:14.495136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:45:13.733322Z","time spent":"761.673113ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T16:45:14.496413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.76131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T16:45:14.496475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.863921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T16:45:14.496478Z","caller":"traceutil/trace.go:171","msg":"trace[658158495] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"501.849599ms","start":"2026-06-09T16:45:13.994611Z","end":"2026-06-09T16:45:14.496461Z","steps":["trace[658158495] 'agreement among raft nodes before linearized reading' (duration: 501.734958ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:45:14.496511Z","caller":"traceutil/trace.go:171","msg":"trace[266887018] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:637; }","duration":"386.955931ms","start":"2026-06-09T16:45:14.109545Z","end":"2026-06-09T16:45:14.496501Z","steps":["trace[266887018] 'agreement among raft nodes before linearized reading' (duration: 386.893315ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:45:14.496519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:45:13.994576Z","time spent":"501.934938ms","remote":"127.0.0.1:39602","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-06-09T16:45:14.496538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:45:14.10952Z","time spent":"387.011547ms","remote":"127.0.0.1:39872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":2,"response size":29,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"info","ts":"2026-06-09T16:45:14.49662Z","caller":"traceutil/trace.go:171","msg":"trace[1519870386] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"465.189626ms","start":"2026-06-09T16:45:14.031257Z","end":"2026-06-09T16:45:14.496446Z","steps":["trace[1519870386] 'process raft request' (duration: 463.73735ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:45:14.497028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:45:14.031232Z","time spent":"465.562344ms","remote":"127.0.0.1:39698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T16:45:26.882986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.480194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T16:45:26.883556Z","caller":"traceutil/trace.go:171","msg":"trace[364249367] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:782; }","duration":"334.642933ms","start":"2026-06-09T16:45:26.548426Z","end":"2026-06-09T16:45:26.883069Z","steps":["trace[364249367] 'count revisions from in-memory index tree' (duration: 334.38856ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:45:26.883617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:45:26.548398Z","time spent":"335.202906ms","remote":"127.0.0.1:39964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":29,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"info","ts":"2026-06-09T16:45:26.927385Z","caller":"traceutil/trace.go:171","msg":"trace[1578450921] linearizableReadLoop","detail":"{readStateIndex:820; appliedIndex:819; }","duration":"366.920306ms","start":"2026-06-09T16:45:26.560414Z","end":"2026-06-09T16:45:26.927334Z","steps":["trace[1578450921] 'read index received' (duration: 366.71867ms)","trace[1578450921] 'applied index is now lower than readState.Index' (duration: 200.717µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T16:45:26.927506Z","caller":"traceutil/trace.go:171","msg":"trace[2130844908] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"377.120925ms","start":"2026-06-09T16:45:26.550375Z","end":"2026-06-09T16:45:26.927496Z","steps":["trace[2130844908] 'process raft request' (duration: 376.818135ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:45:26.927616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:45:26.550348Z","time spent":"377.19056ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T16:45:26.927703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.488364ms","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-06-09T16:45:26.927763Z","caller":"traceutil/trace.go:171","msg":"trace[2093766446] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:783; }","duration":"344.564109ms","start":"2026-06-09T16:45:26.583183Z","end":"2026-06-09T16:45:26.927747Z","steps":["trace[2093766446] 'agreement among raft nodes before linearized reading' (duration: 344.420518ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:45:26.9278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:45:26.583174Z","time spent":"344.619026ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-09T16:45:26.927878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.147844ms","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":"warn","ts":"2026-06-09T16:45:26.927979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.060266ms","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-06-09T16:45:26.92814Z","caller":"traceutil/trace.go:171","msg":"trace[800921425] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:783; }","duration":"323.248123ms","start":"2026-06-09T16:45:26.604869Z","end":"2026-06-09T16:45:26.928117Z","steps":["trace[800921425] 'agreement among raft nodes before linearized reading' (duration: 322.919175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:45:26.927942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.524597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-09T16:45:26.928186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:45:26.604858Z","time spent":"323.317019ms","remote":"127.0.0.1:39870","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-06-09T16:45:26.928106Z","caller":"traceutil/trace.go:171","msg":"trace[1765481059] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:783; }","duration":"120.334172ms","start":"2026-06-09T16:45:26.80767Z","end":"2026-06-09T16:45:26.928004Z","steps":["trace[1765481059] 'agreement among raft nodes before linearized reading' (duration: 120.098458ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:45:26.928238Z","caller":"traceutil/trace.go:171","msg":"trace[987112844] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:783; }","duration":"367.835327ms","start":"2026-06-09T16:45:26.560369Z","end":"2026-06-09T16:45:26.928205Z","steps":["trace[987112844] 'agreement among raft nodes before linearized reading' (duration: 367.507018ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:45:26.928328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:45:26.560351Z","time spent":"367.945929ms","remote":"127.0.0.1:39870","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-06-09T16:45:30.473609Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226738770987549,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T16:45:30.493678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.759794ms","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-06-09T16:45:30.493846Z","caller":"traceutil/trace.go:171","msg":"trace[723359581] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:800; }","duration":"777.940324ms","start":"2026-06-09T16:45:29.715849Z","end":"2026-06-09T16:45:30.49379Z","steps":["trace[723359581] 'range keys from in-memory index tree' (duration: 777.583193ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:45:30.493962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:45:29.715822Z","time spent":"778.126601ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-09T16:45:30.49881Z","caller":"traceutil/trace.go:171","msg":"trace[1431204825] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"650.012857ms","start":"2026-06-09T16:45:29.848771Z","end":"2026-06-09T16:45:30.498784Z","steps":["trace[1431204825] 'process raft request' (duration: 649.885764ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:45:30.498962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:45:29.848745Z","time spent":"650.138551ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T16:45:30.50381Z","caller":"traceutil/trace.go:171","msg":"trace[837922047] linearizableReadLoop","detail":"{readStateIndex:839; appliedIndex:837; }","duration":"531.231605ms","start":"2026-06-09T16:45:29.972537Z","end":"2026-06-09T16:45:30.503769Z","steps":["trace[837922047] 'read index received' (duration: 526.082817ms)","trace[837922047] 'applied index is now lower than readState.Index' (duration: 5.147108ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T16:45:30.503937Z","caller":"traceutil/trace.go:171","msg":"trace[1771666184] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"203.346892ms","start":"2026-06-09T16:45:30.30057Z","end":"2026-06-09T16:45:30.503917Z","steps":["trace[1771666184] 'process raft request' (duration: 202.997742ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:45:30.504391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.825311ms","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-06-09T16:45:30.50445Z","caller":"traceutil/trace.go:171","msg":"trace[435072327] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:802; }","duration":"531.960564ms","start":"2026-06-09T16:45:29.972476Z","end":"2026-06-09T16:45:30.504437Z","steps":["trace[435072327] 'agreement among raft nodes before linearized reading' (duration: 531.47822ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:45:30.504495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:45:29.972451Z","time spent":"532.03447ms","remote":"127.0.0.1:39870","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-06-09T16:45:30.507804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.674696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T16:45:30.507876Z","caller":"traceutil/trace.go:171","msg":"trace[378098097] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:803; }","duration":"512.787381ms","start":"2026-06-09T16:45:29.995073Z","end":"2026-06-09T16:45:30.507861Z","steps":["trace[378098097] 'agreement among raft nodes before linearized reading' (duration: 512.583653ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:45:30.507932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:45:29.995063Z","time spent":"512.862047ms","remote":"127.0.0.1:39602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-09T16:46:09.050404Z","caller":"traceutil/trace.go:171","msg":"trace[2021782859] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"325.470528ms","start":"2026-06-09T16:46:08.724903Z","end":"2026-06-09T16:46:09.050373Z","steps":["trace[2021782859] 'process raft request' (duration: 325.037785ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:46:09.05058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:08.724887Z","time spent":"325.59674ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T16:46:17.262246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.499796ms","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-06-09T16:46:17.262345Z","caller":"traceutil/trace.go:171","msg":"trace[1888800770] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1344; }","duration":"176.660699ms","start":"2026-06-09T16:46:17.085663Z","end":"2026-06-09T16:46:17.262324Z","steps":["trace[1888800770] 'range keys from in-memory index tree' (duration: 176.230722ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:46:21.280353Z","caller":"traceutil/trace.go:171","msg":"trace[2128583229] transaction","detail":"{read_only:false; response_revision:1404; number_of_response:1; }","duration":"158.710388ms","start":"2026-06-09T16:46:21.121421Z","end":"2026-06-09T16:46:21.280131Z","steps":["trace[2128583229] 'process raft request' (duration: 81.528082ms)","trace[2128583229] 'compare' (duration: 76.849079ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T16:46:21.286337Z","caller":"traceutil/trace.go:171","msg":"trace[572819690] transaction","detail":"{read_only:false; response_revision:1406; number_of_response:1; }","duration":"133.346674ms","start":"2026-06-09T16:46:21.152956Z","end":"2026-06-09T16:46:21.286303Z","steps":["trace[572819690] 'process raft request' (duration: 133.047157ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:46:21.286515Z","caller":"traceutil/trace.go:171","msg":"trace[255810227] transaction","detail":"{read_only:false; response_revision:1407; number_of_response:1; }","duration":"132.877663ms","start":"2026-06-09T16:46:21.15361Z","end":"2026-06-09T16:46:21.286488Z","steps":["trace[255810227] 'process raft request' (duration: 132.465084ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:46:21.286719Z","caller":"traceutil/trace.go:171","msg":"trace[1709774026] transaction","detail":"{read_only:false; response_revision:1408; number_of_response:1; }","duration":"132.73573ms","start":"2026-06-09T16:46:21.153972Z","end":"2026-06-09T16:46:21.286708Z","steps":["trace[1709774026] 'process raft request' (duration: 132.148337ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:46:21.286963Z","caller":"traceutil/trace.go:171","msg":"trace[1625025104] transaction","detail":"{read_only:false; response_revision:1405; number_of_response:1; }","duration":"134.787456ms","start":"2026-06-09T16:46:21.152156Z","end":"2026-06-09T16:46:21.286944Z","steps":["trace[1625025104] 'process raft request' (duration: 133.717372ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:46:22.235704Z","caller":"traceutil/trace.go:171","msg":"trace[1244091603] transaction","detail":"{read_only:false; response_revision:1450; number_of_response:1; }","duration":"185.288823ms","start":"2026-06-09T16:46:22.050378Z","end":"2026-06-09T16:46:22.235667Z","steps":["trace[1244091603] 'process raft request' (duration: 136.175681ms)","trace[1244091603] 'compare' (duration: 48.781535ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T16:46:22.235928Z","caller":"traceutil/trace.go:171","msg":"trace[1006720068] transaction","detail":"{read_only:false; response_revision:1452; number_of_response:1; }","duration":"184.540886ms","start":"2026-06-09T16:46:22.051361Z","end":"2026-06-09T16:46:22.235902Z","steps":["trace[1006720068] 'process raft request' (duration: 184.465904ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:46:22.236092Z","caller":"traceutil/trace.go:171","msg":"trace[845277831] transaction","detail":"{read_only:false; response_revision:1451; number_of_response:1; }","duration":"184.72879ms","start":"2026-06-09T16:46:22.051335Z","end":"2026-06-09T16:46:22.236064Z","steps":["trace[845277831] 'process raft request' (duration: 184.370402ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:46:25.965627Z","caller":"traceutil/trace.go:171","msg":"trace[891969734] transaction","detail":"{read_only:false; response_revision:1476; number_of_response:1; }","duration":"275.830709ms","start":"2026-06-09T16:46:25.68977Z","end":"2026-06-09T16:46:25.965601Z","steps":["trace[891969734] 'process raft request' (duration: 275.666615ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:46:51.360788Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226738770989633,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T16:46:51.463321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"756.94528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"} {"level":"info","ts":"2026-06-09T16:46:51.463414Z","caller":"traceutil/trace.go:171","msg":"trace[1503205690] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1888; }","duration":"757.079896ms","start":"2026-06-09T16:46:50.706315Z","end":"2026-06-09T16:46:51.463395Z","steps":["trace[1503205690] 'range keys from in-memory index tree' (duration: 756.765121ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:46:51.463461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:50.706296Z","time spent":"757.15431ms","remote":"127.0.0.1:39766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":10690,"request content":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" "} {"level":"warn","ts":"2026-06-09T16:46:51.463636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.236669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0ac16171-59b0-49e9-a017-6a3c81913025\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-09T16:46:51.463714Z","caller":"traceutil/trace.go:171","msg":"trace[410321438] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0ac16171-59b0-49e9-a017-6a3c81913025; range_end:; response_count:1; response_revision:1888; }","duration":"612.340684ms","start":"2026-06-09T16:46:50.851354Z","end":"2026-06-09T16:46:51.463695Z","steps":["trace[410321438] 'range keys from in-memory index tree' (duration: 612.043781ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:46:51.463757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:50.851337Z","time spent":"612.408458ms","remote":"127.0.0.1:39766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0ac16171-59b0-49e9-a017-6a3c81913025\" "} {"level":"info","ts":"2026-06-09T16:46:51.535453Z","caller":"traceutil/trace.go:171","msg":"trace[311686612] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"675.516994ms","start":"2026-06-09T16:46:50.859916Z","end":"2026-06-09T16:46:51.535433Z","steps":["trace[311686612] 'process raft request' (duration: 675.378668ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:46:51.53562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:50.8599Z","time spent":"675.643601ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T16:46:51.789339Z","caller":"traceutil/trace.go:171","msg":"trace[2123307435] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"645.151535ms","start":"2026-06-09T16:46:51.144164Z","end":"2026-06-09T16:46:51.789315Z","steps":["trace[2123307435] 'process raft request' (duration: 645.04903ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:46:51.78943Z","caller":"traceutil/trace.go:171","msg":"trace[1167707069] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"718.365771ms","start":"2026-06-09T16:46:51.071006Z","end":"2026-06-09T16:46:51.789372Z","steps":["trace[1167707069] 'process raft request' (duration: 718.072067ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:46:51.789526Z","caller":"traceutil/trace.go:171","msg":"trace[913095200] linearizableReadLoop","detail":"{readStateIndex:1971; appliedIndex:1968; }","duration":"929.467053ms","start":"2026-06-09T16:46:50.860026Z","end":"2026-06-09T16:46:51.789493Z","steps":["trace[913095200] 'read index received' (duration: 675.295065ms)","trace[913095200] 'applied index is now lower than readState.Index' (duration: 254.169338ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T16:46:51.78962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:51.144147Z","time spent":"645.322233ms","remote":"127.0.0.1:39764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7742,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T16:46:51.789739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:51.07099Z","time spent":"718.604432ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T16:46:51.789703Z","caller":"traceutil/trace.go:171","msg":"trace[1144401242] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"313.840363ms","start":"2026-06-09T16:46:51.475819Z","end":"2026-06-09T16:46:51.789659Z","steps":["trace[1144401242] 'process raft request' (duration: 313.446615ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:46:51.789753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"929.697864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T16:46:51.789845Z","caller":"traceutil/trace.go:171","msg":"trace[1451042500] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1892; }","duration":"929.85542ms","start":"2026-06-09T16:46:50.85997Z","end":"2026-06-09T16:46:51.789826Z","steps":["trace[1451042500] 'agreement among raft nodes before linearized reading' (duration: 929.692083ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:46:51.789899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:50.859957Z","time spent":"929.931213ms","remote":"127.0.0.1:39896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-06-09T16:46:51.789928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:51.475801Z","time spent":"314.02285ms","remote":"127.0.0.1:39766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10970,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T16:46:52.226451Z","caller":"traceutil/trace.go:171","msg":"trace[207720823] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"685.834686ms","start":"2026-06-09T16:46:51.540588Z","end":"2026-06-09T16:46:52.226423Z","steps":["trace[207720823] 'process raft request' (duration: 645.797167ms)","trace[207720823] 'compare' (duration: 39.82621ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T16:46:52.226616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:51.540564Z","time spent":"685.975933ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T16:46:52.23291Z","caller":"traceutil/trace.go:171","msg":"trace[787500640] linearizableReadLoop","detail":"{readStateIndex:1974; appliedIndex:1972; }","duration":"443.288686ms","start":"2026-06-09T16:46:51.789595Z","end":"2026-06-09T16:46:52.232884Z","steps":["trace[787500640] 'read index received' (duration: 396.735953ms)","trace[787500640] 'applied index is now lower than readState.Index' (duration: 46.550983ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T16:46:52.233172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.284978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-09T16:46:52.233216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.223493ms","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-06-09T16:46:52.233307Z","caller":"traceutil/trace.go:171","msg":"trace[1785194599] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1893; }","duration":"630.348677ms","start":"2026-06-09T16:46:51.602942Z","end":"2026-06-09T16:46:52.233291Z","steps":["trace[1785194599] 'agreement among raft nodes before linearized reading' (duration: 630.117807ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:46:52.233422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.957308ms","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-06-09T16:46:52.233443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.095871602s","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-06-09T16:46:52.233457Z","caller":"traceutil/trace.go:171","msg":"trace[314954766] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1893; }","duration":"615.99076ms","start":"2026-06-09T16:46:51.617458Z","end":"2026-06-09T16:46:52.233448Z","steps":["trace[314954766] 'agreement among raft nodes before linearized reading' (duration: 615.894026ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:46:52.233425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:51.602926Z","time spent":"630.482805ms","remote":"127.0.0.1:45158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-09T16:46:52.233502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:51.61739Z","time spent":"616.105346ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-09T16:46:52.233514Z","caller":"traceutil/trace.go:171","msg":"trace[2045046464] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1893; }","duration":"1.095961817s","start":"2026-06-09T16:46:51.137524Z","end":"2026-06-09T16:46:52.233486Z","steps":["trace[2045046464] 'agreement among raft nodes before linearized reading' (duration: 1.09582089s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:46:52.233561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:51.137504Z","time spent":"1.096048639s","remote":"127.0.0.1:45158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-09T16:46:52.233443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.637203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-09T16:46:52.233747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.135268937s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18b777893385b2f8\" ","response":"range_response_count:1 size:982"} {"level":"info","ts":"2026-06-09T16:46:52.23324Z","caller":"traceutil/trace.go:171","msg":"trace[1559979625] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1893; }","duration":"615.421504ms","start":"2026-06-09T16:46:51.617804Z","end":"2026-06-09T16:46:52.233225Z","steps":["trace[1559979625] 'agreement among raft nodes before linearized reading' (duration: 615.192082ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:46:52.233783Z","caller":"traceutil/trace.go:171","msg":"trace[55390342] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18b777893385b2f8; range_end:; response_count:1; response_revision:1893; }","duration":"1.1353242s","start":"2026-06-09T16:46:51.09845Z","end":"2026-06-09T16:46:52.233774Z","steps":["trace[55390342] 'agreement among raft nodes before linearized reading' (duration: 1.135224285s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:46:52.233808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:51.617783Z","time spent":"616.016022ms","remote":"127.0.0.1:39870","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-06-09T16:46:52.233817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:51.098435Z","time spent":"1.135375403s","remote":"127.0.0.1:39688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":1004,"request content":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18b777893385b2f8\" "} {"level":"info","ts":"2026-06-09T16:46:52.233767Z","caller":"traceutil/trace.go:171","msg":"trace[2143163007] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1893; }","duration":"620.99064ms","start":"2026-06-09T16:46:51.612756Z","end":"2026-06-09T16:46:52.233747Z","steps":["trace[2143163007] 'agreement among raft nodes before linearized reading' (duration: 620.192482ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:46:52.234066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:51.612746Z","time spent":"621.265272ms","remote":"127.0.0.1:39870","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-06-09T16:46:52.233283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.216426836s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-09T16:46:52.234248Z","caller":"traceutil/trace.go:171","msg":"trace[928111175] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"437.820645ms","start":"2026-06-09T16:46:51.796413Z","end":"2026-06-09T16:46:52.234234Z","steps":["trace[928111175] 'process raft request' (duration: 436.418ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:46:52.234258Z","caller":"traceutil/trace.go:171","msg":"trace[1180029903] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1893; }","duration":"1.217440614s","start":"2026-06-09T16:46:51.016806Z","end":"2026-06-09T16:46:52.234247Z","steps":["trace[1180029903] 'agreement among raft nodes before linearized reading' (duration: 1.216294871s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:46:52.234297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:51.0168Z","time spent":"1.217487366s","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-09T16:46:52.23435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:51.796387Z","time spent":"437.89449ms","remote":"127.0.0.1:39750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T16:46:52.233317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.240506432s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T16:46:52.234449Z","caller":"traceutil/trace.go:171","msg":"trace[737968539] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1893; }","duration":"1.241667035s","start":"2026-06-09T16:46:50.992772Z","end":"2026-06-09T16:46:52.234439Z","steps":["trace[737968539] 'agreement among raft nodes before linearized reading' (duration: 1.240516022s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:46:52.234485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:50.992731Z","time spent":"1.241745729s","remote":"127.0.0.1:39602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-09T16:46:52.234693Z","caller":"traceutil/trace.go:171","msg":"trace[1699355547] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"431.745278ms","start":"2026-06-09T16:46:51.802931Z","end":"2026-06-09T16:46:52.234676Z","steps":["trace[1699355547] 'process raft request' (duration: 431.519718ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:46:52.234771Z","caller":"traceutil/trace.go:171","msg":"trace[2035778745] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"171.107168ms","start":"2026-06-09T16:46:52.063651Z","end":"2026-06-09T16:46:52.234758Z","steps":["trace[2035778745] 'process raft request' (duration: 170.866476ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:46:52.234779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.176462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0ac16171-59b0-49e9-a017-6a3c81913025\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-09T16:46:52.234826Z","caller":"traceutil/trace.go:171","msg":"trace[982071839] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0ac16171-59b0-49e9-a017-6a3c81913025; range_end:; response_count:1; response_revision:1899; }","duration":"438.253126ms","start":"2026-06-09T16:46:51.79656Z","end":"2026-06-09T16:46:52.234813Z","steps":["trace[982071839] 'agreement among raft nodes before linearized reading' (duration: 438.089968ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:46:52.234867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:51.796552Z","time spent":"438.305908ms","remote":"127.0.0.1:39766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0ac16171-59b0-49e9-a017-6a3c81913025\" "} {"level":"warn","ts":"2026-06-09T16:46:52.23482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:51.802898Z","time spent":"431.842051ms","remote":"127.0.0.1:39872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T16:46:52.234953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.59548ms","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":"info","ts":"2026-06-09T16:46:52.234988Z","caller":"traceutil/trace.go:171","msg":"trace[489714587] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"436.505156ms","start":"2026-06-09T16:46:51.798471Z","end":"2026-06-09T16:46:52.234977Z","steps":["trace[489714587] 'process raft request' (duration: 435.868136ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:46:52.235004Z","caller":"traceutil/trace.go:171","msg":"trace[1921625711] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1899; }","duration":"364.664243ms","start":"2026-06-09T16:46:51.870317Z","end":"2026-06-09T16:46:52.234982Z","steps":["trace[1921625711] 'agreement among raft nodes before linearized reading' (duration: 364.60393ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:46:52.235037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:51.870302Z","time spent":"364.726476ms","remote":"127.0.0.1:39858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":29,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"info","ts":"2026-06-09T16:46:52.234706Z","caller":"traceutil/trace.go:171","msg":"trace[1809848496] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"436.38844ms","start":"2026-06-09T16:46:51.798304Z","end":"2026-06-09T16:46:52.234693Z","steps":["trace[1809848496] 'process raft request' (duration: 435.794043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:46:52.235083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:51.798465Z","time spent":"436.552718ms","remote":"127.0.0.1:39750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T16:46:52.235178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:51.798267Z","time spent":"436.841952ms","remote":"127.0.0.1:39872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T16:46:52.235558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.974805ms","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-06-09T16:46:52.235654Z","caller":"traceutil/trace.go:171","msg":"trace[2118894571] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1899; }","duration":"615.159244ms","start":"2026-06-09T16:46:51.620483Z","end":"2026-06-09T16:46:52.235642Z","steps":["trace[2118894571] 'agreement among raft nodes before linearized reading' (duration: 614.933813ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:46:52.235686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:46:51.620464Z","time spent":"615.214306ms","remote":"127.0.0.1:39870","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-06-09T16:46:59.83921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.630397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T16:46:59.83928Z","caller":"traceutil/trace.go:171","msg":"trace[1420859922] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1971; }","duration":"144.749744ms","start":"2026-06-09T16:46:59.694517Z","end":"2026-06-09T16:46:59.839267Z","steps":["trace[1420859922] 'count revisions from in-memory index tree' (duration: 144.570935ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:46:59.83941Z","caller":"traceutil/trace.go:171","msg":"trace[1804953306] transaction","detail":"{read_only:false; response_revision:1972; number_of_response:1; }","duration":"106.073219ms","start":"2026-06-09T16:46:59.7333Z","end":"2026-06-09T16:46:59.839374Z","steps":["trace[1804953306] 'process raft request' (duration: 102.255696ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:47:03.824652Z","caller":"traceutil/trace.go:171","msg":"trace[1583059526] transaction","detail":"{read_only:false; response_revision:1997; number_of_response:1; }","duration":"235.068959ms","start":"2026-06-09T16:47:03.589558Z","end":"2026-06-09T16:47:03.824627Z","steps":["trace[1583059526] 'process raft request' (duration: 234.89011ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:47:04.003394Z","caller":"traceutil/trace.go:171","msg":"trace[158524403] transaction","detail":"{read_only:false; response_revision:1998; number_of_response:1; }","duration":"127.057592ms","start":"2026-06-09T16:47:03.876311Z","end":"2026-06-09T16:47:04.003369Z","steps":["trace[158524403] 'process raft request' (duration: 125.820236ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:47:22.283657Z","caller":"traceutil/trace.go:171","msg":"trace[1929037740] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"215.385932ms","start":"2026-06-09T16:47:22.068252Z","end":"2026-06-09T16:47:22.283637Z","steps":["trace[1929037740] 'process raft request' (duration: 215.250674ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:47:22.371045Z","caller":"traceutil/trace.go:171","msg":"trace[733926481] linearizableReadLoop","detail":"{readStateIndex:2200; appliedIndex:2198; }","duration":"157.664253ms","start":"2026-06-09T16:47:22.21336Z","end":"2026-06-09T16:47:22.371024Z","steps":["trace[733926481] 'read index received' (duration: 70.219695ms)","trace[733926481] 'applied index is now lower than readState.Index' (duration: 87.443118ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T16:47:22.371203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.816583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T16:47:22.371193Z","caller":"traceutil/trace.go:171","msg":"trace[1687636989] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"242.16231ms","start":"2026-06-09T16:47:22.129002Z","end":"2026-06-09T16:47:22.371164Z","steps":["trace[1687636989] 'process raft request' (duration: 241.867632ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:47:22.371244Z","caller":"traceutil/trace.go:171","msg":"trace[1759242976] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:2113; }","duration":"157.906438ms","start":"2026-06-09T16:47:22.213325Z","end":"2026-06-09T16:47:22.371232Z","steps":["trace[1759242976] 'agreement among raft nodes before linearized reading' (duration: 157.78461ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:47:22.58854Z","caller":"traceutil/trace.go:171","msg":"trace[564949734] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"229.669596ms","start":"2026-06-09T16:47:22.358831Z","end":"2026-06-09T16:47:22.588501Z","steps":["trace[564949734] 'process raft request' (duration: 178.943764ms)","trace[564949734] 'compare' (duration: 50.478627ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T16:47:22.588612Z","caller":"traceutil/trace.go:171","msg":"trace[280927518] linearizableReadLoop","detail":"{readStateIndex:2203; appliedIndex:2200; }","duration":"184.044767ms","start":"2026-06-09T16:47:22.404554Z","end":"2026-06-09T16:47:22.588599Z","steps":["trace[280927518] 'read index received' (duration: 133.164105ms)","trace[280927518] 'applied index is now lower than readState.Index' (duration: 50.879072ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T16:47:22.588936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.140191ms","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-06-09T16:47:22.588985Z","caller":"traceutil/trace.go:171","msg":"trace[875072438] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2116; }","duration":"140.227796ms","start":"2026-06-09T16:47:22.448748Z","end":"2026-06-09T16:47:22.588976Z","steps":["trace[875072438] 'agreement among raft nodes before linearized reading' (duration: 140.076557ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:47:22.589037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.420164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-09T16:47:22.588929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.985399ms","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-06-09T16:47:22.589058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.412216ms","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-06-09T16:47:22.589089Z","caller":"traceutil/trace.go:171","msg":"trace[745525900] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2116; }","duration":"145.50367ms","start":"2026-06-09T16:47:22.443568Z","end":"2026-06-09T16:47:22.589072Z","steps":["trace[745525900] 'agreement among raft nodes before linearized reading' (duration: 145.404733ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:47:22.589091Z","caller":"traceutil/trace.go:171","msg":"trace[966683108] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2116; }","duration":"181.185072ms","start":"2026-06-09T16:47:22.407895Z","end":"2026-06-09T16:47:22.58908Z","steps":["trace[966683108] 'agreement among raft nodes before linearized reading' (duration: 180.896524ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:47:22.58912Z","caller":"traceutil/trace.go:171","msg":"trace[800431474] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2116; }","duration":"139.494822ms","start":"2026-06-09T16:47:22.449611Z","end":"2026-06-09T16:47:22.589106Z","steps":["trace[800431474] 'agreement among raft nodes before linearized reading' (duration: 139.313511ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:47:22.589032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.149674ms","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-06-09T16:47:22.589188Z","caller":"traceutil/trace.go:171","msg":"trace[494083284] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2116; }","duration":"124.401379ms","start":"2026-06-09T16:47:22.464775Z","end":"2026-06-09T16:47:22.589177Z","steps":["trace[494083284] 'agreement among raft nodes before linearized reading' (duration: 124.022575ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:47:22.588522Z","caller":"traceutil/trace.go:171","msg":"trace[1987619190] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"228.235029ms","start":"2026-06-09T16:47:22.360224Z","end":"2026-06-09T16:47:22.588459Z","steps":["trace[1987619190] 'process raft request' (duration: 228.154473ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:47:22.589691Z","caller":"traceutil/trace.go:171","msg":"trace[187837989] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"226.754419ms","start":"2026-06-09T16:47:22.362913Z","end":"2026-06-09T16:47:22.589667Z","steps":["trace[187837989] 'process raft request' (duration: 225.508262ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:47:22.589799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.24291ms","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-06-09T16:47:22.589852Z","caller":"traceutil/trace.go:171","msg":"trace[1382681494] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2116; }","duration":"185.327265ms","start":"2026-06-09T16:47:22.404511Z","end":"2026-06-09T16:47:22.589838Z","steps":["trace[1382681494] 'agreement among raft nodes before linearized reading' (duration: 184.208536ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:47:23.397042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.179177ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T16:47:23.397346Z","caller":"traceutil/trace.go:171","msg":"trace[1538105225] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"452.964134ms","start":"2026-06-09T16:47:22.944365Z","end":"2026-06-09T16:47:23.397329Z","steps":["trace[1538105225] 'process raft request' (duration: 452.929683ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:47:23.397419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:47:22.944322Z","time spent":"453.0662ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T16:47:23.397725Z","caller":"traceutil/trace.go:171","msg":"trace[1303690317] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"803.486783ms","start":"2026-06-09T16:47:22.594226Z","end":"2026-06-09T16:47:23.397713Z","steps":["trace[1303690317] 'process raft request' (duration: 98.546658ms)","trace[1303690317] 'compare' (duration: 704.051411ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T16:47:23.397789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:47:22.594214Z","time spent":"803.547136ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T16:47:23.397923Z","caller":"traceutil/trace.go:171","msg":"trace[1603333303] linearizableReadLoop","detail":"{readStateIndex:2209; appliedIndex:2204; }","duration":"639.510434ms","start":"2026-06-09T16:47:22.758384Z","end":"2026-06-09T16:47:23.397894Z","steps":["trace[1603333303] 'read index received' (duration: 41.733µs)","trace[1603333303] 'applied index is now lower than readState.Index' (duration: 639.465471ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T16:47:23.398135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.724777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T16:47:23.398179Z","caller":"traceutil/trace.go:171","msg":"trace[1081594281] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2123; }","duration":"639.825814ms","start":"2026-06-09T16:47:22.758343Z","end":"2026-06-09T16:47:23.398169Z","steps":["trace[1081594281] 'agreement among raft nodes before linearized reading' (duration: 639.723698ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:47:23.398216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:47:22.758319Z","time spent":"639.886466ms","remote":"127.0.0.1:52366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-06-09T16:47:23.398216Z","caller":"traceutil/trace.go:171","msg":"trace[1837420581] transaction","detail":"{read_only:false; response_revision:2120; number_of_response:1; }","duration":"803.288361ms","start":"2026-06-09T16:47:22.59491Z","end":"2026-06-09T16:47:23.398198Z","steps":["trace[1837420581] 'process raft request' (duration: 802.282389ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:47:23.39825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.006108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T16:47:23.398286Z","caller":"traceutil/trace.go:171","msg":"trace[1313197336] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2123; }","duration":"419.084323ms","start":"2026-06-09T16:47:22.979192Z","end":"2026-06-09T16:47:23.398276Z","steps":["trace[1313197336] 'agreement among raft nodes before linearized reading' (duration: 419.030819ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:47:23.398323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:47:22.979172Z","time spent":"419.144166ms","remote":"127.0.0.1:39602","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-06-09T16:47:23.398328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:47:22.5949Z","time spent":"803.368436ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T16:47:23.398462Z","caller":"traceutil/trace.go:171","msg":"trace[743390312] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"804.039637ms","start":"2026-06-09T16:47:22.594414Z","end":"2026-06-09T16:47:23.398454Z","steps":["trace[743390312] 'process raft request' (duration: 802.731026ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:47:23.398452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.81277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T16:47:23.398503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:47:22.594405Z","time spent":"804.07815ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T16:47:23.398498Z","caller":"traceutil/trace.go:171","msg":"trace[1572090779] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2123; }","duration":"404.896805ms","start":"2026-06-09T16:47:22.993589Z","end":"2026-06-09T16:47:23.398486Z","steps":["trace[1572090779] 'agreement among raft nodes before linearized reading' (duration: 404.8249ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:47:23.398468Z","caller":"traceutil/trace.go:171","msg":"trace[1881696474] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"803.076717ms","start":"2026-06-09T16:47:22.595353Z","end":"2026-06-09T16:47:23.39843Z","steps":["trace[1881696474] 'process raft request' (duration: 801.908665ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:47:23.398534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:47:22.99357Z","time spent":"404.958009ms","remote":"127.0.0.1:39608","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-06-09T16:47:23.398682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:47:22.595339Z","time spent":"803.205796ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T16:47:23.398704Z","caller":"traceutil/trace.go:171","msg":"trace[846315651] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"803.454061ms","start":"2026-06-09T16:47:22.595234Z","end":"2026-06-09T16:47:23.398688Z","steps":["trace[846315651] 'process raft request' (duration: 801.991401ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:47:23.398799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:47:22.595224Z","time spent":"803.520875ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T16:47:23.974226Z","caller":"traceutil/trace.go:171","msg":"trace[1065751271] linearizableReadLoop","detail":"{readStateIndex:2211; appliedIndex:2210; }","duration":"378.056666ms","start":"2026-06-09T16:47:23.596146Z","end":"2026-06-09T16:47:23.974203Z","steps":["trace[1065751271] 'read index received' (duration: 377.809201ms)","trace[1065751271] 'applied index is now lower than readState.Index' (duration: 246.424µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T16:47:23.974365Z","caller":"traceutil/trace.go:171","msg":"trace[798065797] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"570.922945ms","start":"2026-06-09T16:47:23.403412Z","end":"2026-06-09T16:47:23.974335Z","steps":["trace[798065797] 'process raft request' (duration: 570.641138ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:47:23.974516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:47:23.403389Z","time spent":"571.048233ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T16:47:23.974576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.405618ms","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-06-09T16:47:23.974626Z","caller":"traceutil/trace.go:171","msg":"trace[1212428059] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2124; }","duration":"378.502083ms","start":"2026-06-09T16:47:23.596107Z","end":"2026-06-09T16:47:23.974609Z","steps":["trace[1212428059] 'agreement among raft nodes before linearized reading' (duration: 378.192204ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:47:23.974663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:47:23.59609Z","time spent":"378.565327ms","remote":"127.0.0.1:45158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-09T16:47:24.146619Z","caller":"traceutil/trace.go:171","msg":"trace[1025002253] linearizableReadLoop","detail":"{readStateIndex:2212; appliedIndex:2211; }","duration":"152.654169ms","start":"2026-06-09T16:47:23.993943Z","end":"2026-06-09T16:47:24.146597Z","steps":["trace[1025002253] 'read index received' (duration: 110.6905ms)","trace[1025002253] 'applied index is now lower than readState.Index' (duration: 41.962429ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T16:47:24.146733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.768396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T16:47:24.146803Z","caller":"traceutil/trace.go:171","msg":"trace[1491425619] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2125; }","duration":"152.870422ms","start":"2026-06-09T16:47:23.993917Z","end":"2026-06-09T16:47:24.146787Z","steps":["trace[1491425619] 'agreement among raft nodes before linearized reading' (duration: 152.744864ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:47:24.147108Z","caller":"traceutil/trace.go:171","msg":"trace[1670917186] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"211.088305ms","start":"2026-06-09T16:47:23.935559Z","end":"2026-06-09T16:47:24.146647Z","steps":["trace[1670917186] 'process raft request' (duration: 169.165629ms)","trace[1670917186] 'compare' (duration: 41.660239ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T16:47:24.584032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.117074ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T16:47:24.584534Z","caller":"traceutil/trace.go:171","msg":"trace[2146013345] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2125; }","duration":"186.638156ms","start":"2026-06-09T16:47:24.397854Z","end":"2026-06-09T16:47:24.584492Z","steps":["trace[2146013345] 'range keys from in-memory index tree' (duration: 186.102984ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:47:24.584538Z","caller":"traceutil/trace.go:171","msg":"trace[1041984120] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"417.330579ms","start":"2026-06-09T16:47:24.167177Z","end":"2026-06-09T16:47:24.584507Z","steps":["trace[1041984120] 'process raft request' (duration: 334.054713ms)","trace[1041984120] 'compare' (duration: 82.848619ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T16:47:24.584869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:47:24.167156Z","time spent":"417.566065ms","remote":"127.0.0.1:39688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T16:47:24.585176Z","caller":"traceutil/trace.go:171","msg":"trace[1571834012] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"296.36325ms","start":"2026-06-09T16:47:24.288775Z","end":"2026-06-09T16:47:24.585138Z","steps":["trace[1571834012] 'process raft request' (duration: 295.602882ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:47:24.584716Z","caller":"traceutil/trace.go:171","msg":"trace[735686849] linearizableReadLoop","detail":"{readStateIndex:2215; appliedIndex:2213; }","duration":"106.511215ms","start":"2026-06-09T16:47:24.478179Z","end":"2026-06-09T16:47:24.58469Z","steps":["trace[735686849] 'read index received' (duration: 23.018966ms)","trace[735686849] 'applied index is now lower than readState.Index' (duration: 83.488719ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T16:47:24.585424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.23519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T16:47:24.585474Z","caller":"traceutil/trace.go:171","msg":"trace[329085208] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:2127; }","duration":"107.322836ms","start":"2026-06-09T16:47:24.478139Z","end":"2026-06-09T16:47:24.585462Z","steps":["trace[329085208] 'agreement among raft nodes before linearized reading' (duration: 107.078501ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:49:29.175854Z","caller":"traceutil/trace.go:171","msg":"trace[1687878959] transaction","detail":"{read_only:false; response_revision:2903; number_of_response:1; }","duration":"126.264042ms","start":"2026-06-09T16:49:29.049566Z","end":"2026-06-09T16:49:29.17583Z","steps":["trace[1687878959] 'process raft request' (duration: 126.206888ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:49:29.176132Z","caller":"traceutil/trace.go:171","msg":"trace[908650558] transaction","detail":"{read_only:false; response_revision:2902; number_of_response:1; }","duration":"127.135603ms","start":"2026-06-09T16:49:29.048903Z","end":"2026-06-09T16:49:29.176039Z","steps":["trace[908650558] 'process raft request' (duration: 125.148171ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:52:56.690459Z","caller":"traceutil/trace.go:171","msg":"trace[1160924969] transaction","detail":"{read_only:false; response_revision:4700; number_of_response:1; }","duration":"115.812093ms","start":"2026-06-09T16:52:56.574621Z","end":"2026-06-09T16:52:56.690433Z","steps":["trace[1160924969] 'process raft request' (duration: 115.691797ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:52:56.690871Z","caller":"traceutil/trace.go:171","msg":"trace[1426791475] transaction","detail":"{read_only:false; response_revision:4699; number_of_response:1; }","duration":"117.140672ms","start":"2026-06-09T16:52:56.573719Z","end":"2026-06-09T16:52:56.69086Z","steps":["trace[1426791475] 'process raft request' (duration: 115.52215ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:00.125213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.072604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T16:53:00.125383Z","caller":"traceutil/trace.go:171","msg":"trace[337291261] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4782; }","duration":"130.295374ms","start":"2026-06-09T16:52:59.995065Z","end":"2026-06-09T16:53:00.125361Z","steps":["trace[337291261] 'range keys from in-memory index tree' (duration: 129.98428ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:53:00.125668Z","caller":"traceutil/trace.go:171","msg":"trace[1899404948] transaction","detail":"{read_only:false; response_revision:4783; number_of_response:1; }","duration":"113.647446ms","start":"2026-06-09T16:53:00.011979Z","end":"2026-06-09T16:53:00.125626Z","steps":["trace[1899404948] 'process raft request' (duration: 94.756533ms)","trace[1899404948] 'compare' (duration: 18.089846ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T16:53:00.126662Z","caller":"traceutil/trace.go:171","msg":"trace[1118777454] transaction","detail":"{read_only:false; response_revision:4784; number_of_response:1; }","duration":"110.802926ms","start":"2026-06-09T16:53:00.015821Z","end":"2026-06-09T16:53:00.126624Z","steps":["trace[1118777454] 'process raft request' (duration: 110.132245ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:53:00.812197Z","caller":"traceutil/trace.go:171","msg":"trace[425348899] transaction","detail":"{read_only:false; response_revision:4788; number_of_response:1; }","duration":"262.990739ms","start":"2026-06-09T16:53:00.549164Z","end":"2026-06-09T16:53:00.812155Z","steps":["trace[425348899] 'process raft request' (duration: 262.834412ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:53:00.826295Z","caller":"traceutil/trace.go:171","msg":"trace[784175783] transaction","detail":"{read_only:false; response_revision:4789; number_of_response:1; }","duration":"277.009029ms","start":"2026-06-09T16:53:00.549235Z","end":"2026-06-09T16:53:00.826244Z","steps":["trace[784175783] 'process raft request' (duration: 276.892014ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:53:01.016785Z","caller":"traceutil/trace.go:171","msg":"trace[1751930547] transaction","detail":"{read_only:false; response_revision:4791; number_of_response:1; }","duration":"135.841721ms","start":"2026-06-09T16:53:00.880918Z","end":"2026-06-09T16:53:01.01676Z","steps":["trace[1751930547] 'process raft request' (duration: 135.634261ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:53:01.060046Z","caller":"traceutil/trace.go:171","msg":"trace[1998961095] transaction","detail":"{read_only:false; response_revision:4792; number_of_response:1; }","duration":"178.777058ms","start":"2026-06-09T16:53:00.881245Z","end":"2026-06-09T16:53:01.060022Z","steps":["trace[1998961095] 'process raft request' (duration: 178.629801ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:01.332095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.472746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3a19b35b-db21-43e4-872b-282cae173736\" ","response":"range_response_count:1 size:3766"} {"level":"info","ts":"2026-06-09T16:53:01.332221Z","caller":"traceutil/trace.go:171","msg":"trace[49268165] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3a19b35b-db21-43e4-872b-282cae173736; range_end:; response_count:1; response_revision:4792; }","duration":"200.642333ms","start":"2026-06-09T16:53:01.13156Z","end":"2026-06-09T16:53:01.332202Z","steps":["trace[49268165] 'range keys from in-memory index tree' (duration: 200.271507ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:01.332421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.668211ms","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-06-09T16:53:01.332525Z","caller":"traceutil/trace.go:171","msg":"trace[450244044] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4792; }","duration":"110.793106ms","start":"2026-06-09T16:53:01.221707Z","end":"2026-06-09T16:53:01.3325Z","steps":["trace[450244044] 'range keys from in-memory index tree' (duration: 110.44762ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:01.332544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.931916ms","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-06-09T16:53:01.332429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.485942ms","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-06-09T16:53:01.332597Z","caller":"traceutil/trace.go:171","msg":"trace[884155196] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4792; }","duration":"114.997708ms","start":"2026-06-09T16:53:01.217585Z","end":"2026-06-09T16:53:01.332582Z","steps":["trace[884155196] 'range keys from in-memory index tree' (duration: 114.793178ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:53:01.33262Z","caller":"traceutil/trace.go:171","msg":"trace[629330904] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4792; }","duration":"122.726914ms","start":"2026-06-09T16:53:01.209876Z","end":"2026-06-09T16:53:01.332603Z","steps":["trace[629330904] 'range keys from in-memory index tree' (duration: 122.300244ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:01.332049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.646377ms","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-06-09T16:53:01.332842Z","caller":"traceutil/trace.go:171","msg":"trace[74192285] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4792; }","duration":"138.460375ms","start":"2026-06-09T16:53:01.194361Z","end":"2026-06-09T16:53:01.332821Z","steps":["trace[74192285] 'range keys from in-memory index tree' (duration: 137.51365ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:53:01.554646Z","caller":"traceutil/trace.go:171","msg":"trace[1507767378] transaction","detail":"{read_only:false; response_revision:4793; number_of_response:1; }","duration":"217.639152ms","start":"2026-06-09T16:53:01.336989Z","end":"2026-06-09T16:53:01.554629Z","steps":["trace[1507767378] 'process raft request' (duration: 217.524907ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:53:01.709569Z","caller":"traceutil/trace.go:171","msg":"trace[442023466] transaction","detail":"{read_only:false; response_revision:4795; number_of_response:1; }","duration":"372.070778ms","start":"2026-06-09T16:53:01.337479Z","end":"2026-06-09T16:53:01.70955Z","steps":["trace[442023466] 'process raft request' (duration: 372.013455ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:01.709689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:53:01.337472Z","time spent":"372.153982ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T16:53:01.709923Z","caller":"traceutil/trace.go:171","msg":"trace[1767540941] transaction","detail":"{read_only:false; response_revision:4794; number_of_response:1; }","duration":"372.772851ms","start":"2026-06-09T16:53:01.33712Z","end":"2026-06-09T16:53:01.709893Z","steps":["trace[1767540941] 'process raft request' (duration: 298.603243ms)","trace[1767540941] 'compare' (duration: 73.502827ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T16:53:01.709965Z","caller":"traceutil/trace.go:171","msg":"trace[362472600] transaction","detail":"{read_only:false; response_revision:4796; number_of_response:1; }","duration":"372.416274ms","start":"2026-06-09T16:53:01.337515Z","end":"2026-06-09T16:53:01.709932Z","steps":["trace[362472600] 'process raft request' (duration: 372.007315ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:01.710124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:53:01.337095Z","time spent":"372.895205ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T16:53:01.710207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:53:01.337512Z","time spent":"372.581721ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T16:53:01.710306Z","caller":"traceutil/trace.go:171","msg":"trace[1444015268] linearizableReadLoop","detail":"{readStateIndex:4985; appliedIndex:4980; }","duration":"161.873367ms","start":"2026-06-09T16:53:01.548422Z","end":"2026-06-09T16:53:01.710296Z","steps":["trace[1444015268] 'read index received' (duration: 6.192024ms)","trace[1444015268] 'applied index is now lower than readState.Index' (duration: 155.680403ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T16:53:01.710375Z","caller":"traceutil/trace.go:171","msg":"trace[560905800] transaction","detail":"{read_only:false; response_revision:4797; number_of_response:1; }","duration":"280.131455ms","start":"2026-06-09T16:53:01.430231Z","end":"2026-06-09T16:53:01.710363Z","steps":["trace[560905800] 'process raft request' (duration: 279.561079ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:53:01.710384Z","caller":"traceutil/trace.go:171","msg":"trace[1112101256] transaction","detail":"{read_only:false; response_revision:4798; number_of_response:1; }","duration":"204.076611ms","start":"2026-06-09T16:53:01.506299Z","end":"2026-06-09T16:53:01.710375Z","steps":["trace[1112101256] 'process raft request' (duration: 203.955645ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:01.710408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.989212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-674dc877d6-dd4gh.18b777dfc09aecf6\" ","response":"range_response_count:1 size:898"} {"level":"info","ts":"2026-06-09T16:53:01.710432Z","caller":"traceutil/trace.go:171","msg":"trace[1922551367] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-674dc877d6-dd4gh.18b777dfc09aecf6; range_end:; response_count:1; response_revision:4798; }","duration":"162.045164ms","start":"2026-06-09T16:53:01.54838Z","end":"2026-06-09T16:53:01.710425Z","steps":["trace[1922551367] 'agreement among raft nodes before linearized reading' (duration: 161.95068ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:53:04.916549Z","caller":"traceutil/trace.go:171","msg":"trace[952765046] linearizableReadLoop","detail":"{readStateIndex:5019; appliedIndex:5018; }","duration":"336.039098ms","start":"2026-06-09T16:53:04.58049Z","end":"2026-06-09T16:53:04.916529Z","steps":["trace[952765046] 'read index received' (duration: 335.914822ms)","trace[952765046] 'applied index is now lower than readState.Index' (duration: 123.406µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T16:53:04.91664Z","caller":"traceutil/trace.go:171","msg":"trace[1958218031] transaction","detail":"{read_only:false; response_revision:4831; number_of_response:1; }","duration":"418.155078ms","start":"2026-06-09T16:53:04.498475Z","end":"2026-06-09T16:53:04.91663Z","steps":["trace[1958218031] 'process raft request' (duration: 417.899606ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:04.916935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:53:04.498455Z","time spent":"418.20567ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T16:53:04.917186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.666938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13296"} {"level":"info","ts":"2026-06-09T16:53:04.917436Z","caller":"traceutil/trace.go:171","msg":"trace[250691359] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4831; }","duration":"336.993583ms","start":"2026-06-09T16:53:04.580423Z","end":"2026-06-09T16:53:04.917416Z","steps":["trace[250691359] 'agreement among raft nodes before linearized reading' (duration: 336.308221ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:04.917537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:53:04.580393Z","time spent":"337.12695ms","remote":"127.0.0.1:39766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":13318,"request content":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-06-09T16:53:04.922186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.921831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-09T16:53:04.922245Z","caller":"traceutil/trace.go:171","msg":"trace[1977870561] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:4833; }","duration":"267.038319ms","start":"2026-06-09T16:53:04.655193Z","end":"2026-06-09T16:53:04.922232Z","steps":["trace[1977870561] 'agreement among raft nodes before linearized reading' (duration: 266.672802ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:53:04.922246Z","caller":"traceutil/trace.go:171","msg":"trace[1615205869] transaction","detail":"{read_only:false; response_revision:4832; number_of_response:1; }","duration":"339.823604ms","start":"2026-06-09T16:53:04.582389Z","end":"2026-06-09T16:53:04.922213Z","steps":["trace[1615205869] 'process raft request' (duration: 339.332032ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:04.922383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:53:04.582374Z","time spent":"339.94307ms","remote":"127.0.0.1:39688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":853,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T16:53:04.922504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.062613ms","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-06-09T16:53:04.922551Z","caller":"traceutil/trace.go:171","msg":"trace[662497041] 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:4833; }","duration":"252.108975ms","start":"2026-06-09T16:53:04.670427Z","end":"2026-06-09T16:53:04.922536Z","steps":["trace[662497041] 'agreement among raft nodes before linearized reading' (duration: 251.989269ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:53:05.514966Z","caller":"traceutil/trace.go:171","msg":"trace[1474408416] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"109.749401ms","start":"2026-06-09T16:53:05.405189Z","end":"2026-06-09T16:53:05.514939Z","steps":["trace[1474408416] 'process raft request' (duration: 68.91269ms)","trace[1474408416] 'compare' (duration: 40.727507ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T16:53:15.025026Z","caller":"traceutil/trace.go:171","msg":"trace[243511341] linearizableReadLoop","detail":"{readStateIndex:5151; appliedIndex:5150; }","duration":"293.067059ms","start":"2026-06-09T16:53:14.731913Z","end":"2026-06-09T16:53:15.024981Z","steps":["trace[243511341] 'read index received' (duration: 292.67896ms)","trace[243511341] 'applied index is now lower than readState.Index' (duration: 385.989µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T16:53:15.025705Z","caller":"traceutil/trace.go:171","msg":"trace[1265343837] transaction","detail":"{read_only:false; response_revision:4957; number_of_response:1; }","duration":"345.78909ms","start":"2026-06-09T16:53:14.679877Z","end":"2026-06-09T16:53:15.025666Z","steps":["trace[1265343837] 'process raft request' (duration: 344.853715ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:15.025989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:53:14.679863Z","time spent":"345.902466ms","remote":"127.0.0.1:39766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10670,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T16:53:15.026451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.536049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-09T16:53:15.026497Z","caller":"traceutil/trace.go:171","msg":"trace[1765394682] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4957; }","duration":"294.612023ms","start":"2026-06-09T16:53:14.73187Z","end":"2026-06-09T16:53:15.026482Z","steps":["trace[1765394682] 'agreement among raft nodes before linearized reading' (duration: 294.433355ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:15.654289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.595071ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T16:53:15.654382Z","caller":"traceutil/trace.go:171","msg":"trace[1742343747] linearizableReadLoop","detail":"{readStateIndex:5152; appliedIndex:5151; }","duration":"621.553435ms","start":"2026-06-09T16:53:15.032811Z","end":"2026-06-09T16:53:15.654365Z","steps":["trace[1742343747] 'read index received' (duration: 499.745503ms)","trace[1742343747] 'applied index is now lower than readState.Index' (duration: 121.806872ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T16:53:15.654448Z","caller":"traceutil/trace.go:171","msg":"trace[1391594141] transaction","detail":"{read_only:false; response_revision:4958; number_of_response:1; }","duration":"621.65836ms","start":"2026-06-09T16:53:15.032778Z","end":"2026-06-09T16:53:15.654436Z","steps":["trace[1391594141] 'process raft request' (duration: 499.772464ms)","trace[1391594141] 'compare' (duration: 121.452765ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T16:53:15.65451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:53:15.032759Z","time spent":"621.721442ms","remote":"127.0.0.1:39750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":951,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T16:53:15.654818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.996686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-3a19b35b-db21-43e4-872b-282cae173736\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-06-09T16:53:15.654878Z","caller":"traceutil/trace.go:171","msg":"trace[1866218591] range","detail":"{range_begin:/registry/persistentvolumes/pvc-3a19b35b-db21-43e4-872b-282cae173736; range_end:; response_count:1; response_revision:4958; }","duration":"622.0857ms","start":"2026-06-09T16:53:15.032774Z","end":"2026-06-09T16:53:15.654859Z","steps":["trace[1866218591] 'agreement among raft nodes before linearized reading' (duration: 621.849309ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:15.654953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:53:15.032754Z","time spent":"622.186774ms","remote":"127.0.0.1:39740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1344,"request content":"key:\"/registry/persistentvolumes/pvc-3a19b35b-db21-43e4-872b-282cae173736\" "} {"level":"info","ts":"2026-06-09T16:53:15.697656Z","caller":"traceutil/trace.go:171","msg":"trace[533799393] transaction","detail":"{read_only:false; response_revision:4959; number_of_response:1; }","duration":"664.773625ms","start":"2026-06-09T16:53:15.032863Z","end":"2026-06-09T16:53:15.697636Z","steps":["trace[533799393] 'process raft request' (duration: 664.106593ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:53:15.698225Z","caller":"traceutil/trace.go:171","msg":"trace[474785994] transaction","detail":"{read_only:false; response_revision:4964; number_of_response:1; }","duration":"180.642498ms","start":"2026-06-09T16:53:15.517552Z","end":"2026-06-09T16:53:15.698194Z","steps":["trace[474785994] 'process raft request' (duration: 179.824348ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:15.698412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.773054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T16:53:15.698479Z","caller":"traceutil/trace.go:171","msg":"trace[741854293] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:4964; }","duration":"278.862599ms","start":"2026-06-09T16:53:15.419591Z","end":"2026-06-09T16:53:15.698454Z","steps":["trace[741854293] 'agreement among raft nodes before linearized reading' (duration: 278.695751ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:15.698529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:53:15.032859Z","time spent":"664.857249ms","remote":"127.0.0.1:39750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T16:53:15.698871Z","caller":"traceutil/trace.go:171","msg":"trace[907048918] transaction","detail":"{read_only:false; response_revision:4960; number_of_response:1; }","duration":"665.756773ms","start":"2026-06-09T16:53:15.0331Z","end":"2026-06-09T16:53:15.698856Z","steps":["trace[907048918] 'process raft request' (duration: 663.981938ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:15.699019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.056647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T16:53:15.699058Z","caller":"traceutil/trace.go:171","msg":"trace[677227298] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:4964; }","duration":"659.095699ms","start":"2026-06-09T16:53:15.039952Z","end":"2026-06-09T16:53:15.699048Z","steps":["trace[677227298] 'agreement among raft nodes before linearized reading' (duration: 658.981294ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:15.699089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:53:15.039932Z","time spent":"659.148783ms","remote":"127.0.0.1:52168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-06-09T16:53:15.699142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:53:15.03309Z","time spent":"665.876638ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T16:53:15.698234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.279099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T16:53:15.699457Z","caller":"traceutil/trace.go:171","msg":"trace[380619803] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4964; }","duration":"666.501617ms","start":"2026-06-09T16:53:15.032909Z","end":"2026-06-09T16:53:15.699411Z","steps":["trace[380619803] 'agreement among raft nodes before linearized reading' (duration: 665.183324ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:15.699567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:53:15.032905Z","time spent":"666.627254ms","remote":"127.0.0.1:39608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-09T16:53:15.699688Z","caller":"traceutil/trace.go:171","msg":"trace[1099194794] transaction","detail":"{read_only:false; response_revision:4962; number_of_response:1; }","duration":"665.716521ms","start":"2026-06-09T16:53:15.033957Z","end":"2026-06-09T16:53:15.699674Z","steps":["trace[1099194794] 'process raft request' (duration: 663.22565ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:53:15.699789Z","caller":"traceutil/trace.go:171","msg":"trace[1559794858] transaction","detail":"{read_only:false; response_revision:4963; number_of_response:1; }","duration":"448.920503ms","start":"2026-06-09T16:53:15.250855Z","end":"2026-06-09T16:53:15.699776Z","steps":["trace[1559794858] 'process raft request' (duration: 446.474955ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:15.699885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:53:15.250831Z","time spent":"448.991068ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T16:53:15.699906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:53:15.033951Z","time spent":"665.835426ms","remote":"127.0.0.1:39872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1429,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T16:53:15.698909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.762093ms","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-06-09T16:53:15.700085Z","caller":"traceutil/trace.go:171","msg":"trace[416098196] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:4964; }","duration":"636.074117ms","start":"2026-06-09T16:53:15.063999Z","end":"2026-06-09T16:53:15.700073Z","steps":["trace[416098196] 'agreement among raft nodes before linearized reading' (duration: 634.778934ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:15.700126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:53:15.063983Z","time spent":"636.130979ms","remote":"127.0.0.1:40098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":4,"response size":29,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-06-09T16:53:15.699706Z","caller":"traceutil/trace.go:171","msg":"trace[1035237458] transaction","detail":"{read_only:false; response_revision:4961; number_of_response:1; }","duration":"666.154362ms","start":"2026-06-09T16:53:15.033534Z","end":"2026-06-09T16:53:15.699688Z","steps":["trace[1035237458] 'process raft request' (duration: 663.600979ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:15.701687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T16:53:15.033526Z","time spent":"668.093325ms","remote":"127.0.0.1:39872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1506,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T16:53:15.999745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.704104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-09T16:53:15.999844Z","caller":"traceutil/trace.go:171","msg":"trace[1106366304] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4965; }","duration":"239.850491ms","start":"2026-06-09T16:53:15.75997Z","end":"2026-06-09T16:53:15.999821Z","steps":["trace[1106366304] 'range keys from in-memory index tree' (duration: 239.467373ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:16.000864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.530806ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T16:53:16.001321Z","caller":"traceutil/trace.go:171","msg":"trace[2110860816] transaction","detail":"{read_only:false; response_revision:4966; number_of_response:1; }","duration":"237.245986ms","start":"2026-06-09T16:53:15.764057Z","end":"2026-06-09T16:53:16.001303Z","steps":["trace[2110860816] 'process raft request' (duration: 46.213436ms)","trace[2110860816] 'compare' (duration: 189.822852ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T16:53:16.001456Z","caller":"traceutil/trace.go:171","msg":"trace[826292654] linearizableReadLoop","detail":"{readStateIndex:5160; appliedIndex:5159; }","duration":"233.59869ms","start":"2026-06-09T16:53:15.767847Z","end":"2026-06-09T16:53:16.001445Z","steps":["trace[826292654] 'read index received' (duration: 42.340979ms)","trace[826292654] 'applied index is now lower than readState.Index' (duration: 191.256421ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T16:53:16.001707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.858241ms","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-06-09T16:53:16.001763Z","caller":"traceutil/trace.go:171","msg":"trace[907505003] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4967; }","duration":"233.950687ms","start":"2026-06-09T16:53:15.767797Z","end":"2026-06-09T16:53:16.001747Z","steps":["trace[907505003] 'agreement among raft nodes before linearized reading' (duration: 233.842921ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:16.00256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.194604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-09T16:53:16.002607Z","caller":"traceutil/trace.go:171","msg":"trace[2049596626] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4967; }","duration":"224.255998ms","start":"2026-06-09T16:53:15.778339Z","end":"2026-06-09T16:53:16.002595Z","steps":["trace[2049596626] 'agreement among raft nodes before linearized reading' (duration: 223.668769ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T16:53:16.002995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.103014ms","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-06-09T16:53:16.003031Z","caller":"traceutil/trace.go:171","msg":"trace[1503313340] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4967; }","duration":"216.161575ms","start":"2026-06-09T16:53:15.786861Z","end":"2026-06-09T16:53:16.003022Z","steps":["trace[1503313340] 'agreement among raft nodes before linearized reading' (duration: 216.077531ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:53:16.169702Z","caller":"traceutil/trace.go:171","msg":"trace[270041185] transaction","detail":"{read_only:false; response_revision:4969; number_of_response:1; }","duration":"161.416956ms","start":"2026-06-09T16:53:16.008255Z","end":"2026-06-09T16:53:16.169672Z","steps":["trace[270041185] 'process raft request' (duration: 106.777283ms)","trace[270041185] 'compare' (duration: 54.242103ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T16:53:16.169875Z","caller":"traceutil/trace.go:171","msg":"trace[2107820421] transaction","detail":"{read_only:false; response_revision:4970; number_of_response:1; }","duration":"160.904421ms","start":"2026-06-09T16:53:16.008948Z","end":"2026-06-09T16:53:16.169852Z","steps":["trace[2107820421] 'process raft request' (duration: 160.476771ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:53:20.30639Z","caller":"traceutil/trace.go:171","msg":"trace[1297352363] transaction","detail":"{read_only:false; response_revision:5015; number_of_response:1; }","duration":"115.640772ms","start":"2026-06-09T16:53:20.190727Z","end":"2026-06-09T16:53:20.306368Z","steps":["trace[1297352363] 'process raft request' (duration: 115.511655ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:53:20.312866Z","caller":"traceutil/trace.go:171","msg":"trace[1727889333] transaction","detail":"{read_only:false; response_revision:5016; number_of_response:1; }","duration":"120.846548ms","start":"2026-06-09T16:53:20.192007Z","end":"2026-06-09T16:53:20.312854Z","steps":["trace[1727889333] 'process raft request' (duration: 120.780694ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T16:54:13.360584Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2820} {"level":"info","ts":"2026-06-09T16:54:13.430335Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2820,"took":"68.24613ms","hash":3525528235,"current-db-size-bytes":54140928,"current-db-size":"54 MB","current-db-size-in-use-bytes":29319168,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-09T16:54:13.430397Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3525528235,"revision":2820,"compact-revision":-1} {"level":"info","ts":"2026-06-09T16:59:13.367383Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5499} {"level":"info","ts":"2026-06-09T16:59:13.482052Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5499,"took":"112.300948ms","hash":1640596226,"current-db-size-bytes":54140928,"current-db-size":"54 MB","current-db-size-in-use-bytes":18448384,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-09T16:59:13.482111Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1640596226,"revision":5499,"compact-revision":2820} {"level":"info","ts":"2026-06-09T17:00:30.672603Z","caller":"traceutil/trace.go:171","msg":"trace[277058311] linearizableReadLoop","detail":"{readStateIndex:8043; appliedIndex:8042; }","duration":"102.225607ms","start":"2026-06-09T17:00:30.570338Z","end":"2026-06-09T17:00:30.672564Z","steps":["trace[277058311] 'read index received' (duration: 101.84286ms)","trace[277058311] 'applied index is now lower than readState.Index' (duration: 381.777µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:00:30.672853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.491256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-09T17:00:30.672697Z","caller":"traceutil/trace.go:171","msg":"trace[1711219542] transaction","detail":"{read_only:false; response_revision:7749; number_of_response:1; }","duration":"106.965907ms","start":"2026-06-09T17:00:30.565699Z","end":"2026-06-09T17:00:30.672665Z","steps":["trace[1711219542] 'process raft request' (duration: 106.60824ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:00:30.672932Z","caller":"traceutil/trace.go:171","msg":"trace[643389290] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7749; }","duration":"102.606695ms","start":"2026-06-09T17:00:30.570305Z","end":"2026-06-09T17:00:30.672912Z","steps":["trace[643389290] 'agreement among raft nodes before linearized reading' (duration: 102.398296ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:00:38.185848Z","caller":"traceutil/trace.go:171","msg":"trace[1282044546] transaction","detail":"{read_only:false; response_revision:7783; number_of_response:1; }","duration":"104.505055ms","start":"2026-06-09T17:00:38.081328Z","end":"2026-06-09T17:00:38.185833Z","steps":["trace[1282044546] 'process raft request' (duration: 104.410026ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:00:38.202985Z","caller":"traceutil/trace.go:171","msg":"trace[1667378108] transaction","detail":"{read_only:false; response_revision:7784; number_of_response:1; }","duration":"120.624237ms","start":"2026-06-09T17:00:38.082333Z","end":"2026-06-09T17:00:38.202957Z","steps":["trace[1667378108] 'process raft request' (duration: 120.448998ms)"],"step_count":1}