{"level":"warn","ts":"2026-05-28T12:31:10.321244Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-28T12:31:10.321326Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.221:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.221:2380","--initial-cluster=instance=https://199.19.213.221:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.221:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.221:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-28T12:31:10.321386Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-28T12:31:10.321396Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.221:2380"]} {"level":"info","ts":"2026-05-28T12:31:10.32141Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-28T12:31:10.323111Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.221:2379"]} {"level":"info","ts":"2026-05-28T12:31:10.323247Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.221:2380"],"listen-peer-urls":["https://199.19.213.221:2380"],"advertise-client-urls":["https://199.19.213.221:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.221:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.221:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-28T12:31:10.327161Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.643857ms"} {"level":"info","ts":"2026-05-28T12:31:10.338298Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b506daf99e68981a","cluster-id":"d2c45690f9793857"} {"level":"info","ts":"2026-05-28T12:31:10.338383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a switched to configuration voters=()"} {"level":"info","ts":"2026-05-28T12:31:10.338404Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a became follower at term 0"} {"level":"info","ts":"2026-05-28T12:31:10.338432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b506daf99e68981a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-28T12:31:10.338444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a became follower at term 1"} {"level":"info","ts":"2026-05-28T12:31:10.33852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a switched to configuration voters=(13044354136364587034)"} {"level":"warn","ts":"2026-05-28T12:31:10.345102Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-28T12:31:10.34648Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-28T12:31:10.347703Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-28T12:31:10.349799Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b506daf99e68981a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-28T12:31:10.349948Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b506daf99e68981a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-28T12:31:10.350269Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-28T12:31:10.35035Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-28T12:31:10.35038Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-28T12:31:10.352169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a switched to configuration voters=(13044354136364587034)"} {"level":"info","ts":"2026-05-28T12:31:10.352847Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d2c45690f9793857","local-member-id":"b506daf99e68981a","added-peer-id":"b506daf99e68981a","added-peer-peer-urls":["https://199.19.213.221:2380"]} {"level":"info","ts":"2026-05-28T12:31:10.354329Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-28T12:31:10.354434Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.221:2380"} {"level":"info","ts":"2026-05-28T12:31:10.35451Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.221:2380"} {"level":"info","ts":"2026-05-28T12:31:10.354599Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b506daf99e68981a","initial-advertise-peer-urls":["https://199.19.213.221:2380"],"listen-peer-urls":["https://199.19.213.221:2380"],"advertise-client-urls":["https://199.19.213.221:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.221:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-28T12:31:10.354633Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-28T12:31:11.239325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a is starting a new election at term 1"} {"level":"info","ts":"2026-05-28T12:31:11.23944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a became pre-candidate at term 1"} {"level":"info","ts":"2026-05-28T12:31:11.239464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a received MsgPreVoteResp from b506daf99e68981a at term 1"} {"level":"info","ts":"2026-05-28T12:31:11.239483Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a became candidate at term 2"} {"level":"info","ts":"2026-05-28T12:31:11.239494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a received MsgVoteResp from b506daf99e68981a at term 2"} {"level":"info","ts":"2026-05-28T12:31:11.239509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b506daf99e68981a became leader at term 2"} {"level":"info","ts":"2026-05-28T12:31:11.23953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b506daf99e68981a elected leader b506daf99e68981a at term 2"} {"level":"info","ts":"2026-05-28T12:31:11.426344Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b506daf99e68981a","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.221:2379]}","request-path":"/0/members/b506daf99e68981a/attributes","cluster-id":"d2c45690f9793857","publish-timeout":"7s"} {"level":"info","ts":"2026-05-28T12:31:11.426387Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-28T12:31:11.426596Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-28T12:31:11.42679Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T12:31:11.427345Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-28T12:31:11.42742Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-28T12:31:11.42935Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.221:2379"} {"level":"info","ts":"2026-05-28T12:31:11.429814Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-28T12:31:11.663527Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d2c45690f9793857","local-member-id":"b506daf99e68981a","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T12:31:11.663787Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T12:31:11.663865Z","caller":"traceutil/trace.go:171","msg":"trace[1171651857] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:3; }","duration":"185.355792ms","start":"2026-05-28T12:31:11.478478Z","end":"2026-05-28T12:31:11.663834Z","steps":["trace[1171651857] 'read index received' (duration: 184.886393ms)","trace[1171651857] 'applied index is now lower than readState.Index' (duration: 468.169µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:31:11.663983Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-05-28T12:31:11.664711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.195637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-28T12:31:11.664869Z","caller":"traceutil/trace.go:171","msg":"trace[612818773] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"186.34042ms","start":"2026-05-28T12:31:11.478472Z","end":"2026-05-28T12:31:11.664812Z","steps":["trace[612818773] 'agreement among raft nodes before linearized reading' (duration: 185.516434ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:31:11.664938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.365512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-28T12:31:11.665013Z","caller":"traceutil/trace.go:171","msg":"trace[41290228] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"186.455672ms","start":"2026-05-28T12:31:11.478523Z","end":"2026-05-28T12:31:11.664979Z","steps":["trace[41290228] 'agreement among raft nodes before linearized reading' (duration: 185.514426ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:31:11.665637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.063962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-28T12:31:11.665747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.798084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-28T12:31:11.665793Z","caller":"traceutil/trace.go:171","msg":"trace[1708857129] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"137.858535ms","start":"2026-05-28T12:31:11.527915Z","end":"2026-05-28T12:31:11.665773Z","steps":["trace[1708857129] 'agreement among raft nodes before linearized reading' (duration: 137.786834ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:31:11.665972Z","caller":"traceutil/trace.go:171","msg":"trace[793109052] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"108.368158ms","start":"2026-05-28T12:31:11.557553Z","end":"2026-05-28T12:31:11.665921Z","steps":["trace[793109052] 'agreement among raft nodes before linearized reading' (duration: 107.94974ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:31:11.666303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.711474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-28T12:31:11.666506Z","caller":"traceutil/trace.go:171","msg":"trace[1964328644] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"108.942897ms","start":"2026-05-28T12:31:11.557527Z","end":"2026-05-28T12:31:11.66647Z","steps":["trace[1964328644] 'agreement among raft nodes before linearized reading' (duration: 108.154673ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:31:11.668473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.169254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-28T12:31:11.668521Z","caller":"traceutil/trace.go:171","msg":"trace[2032536327] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"125.269716ms","start":"2026-05-28T12:31:11.543238Z","end":"2026-05-28T12:31:11.668508Z","steps":["trace[2032536327] 'agreement among raft nodes before linearized reading' (duration: 122.455835ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:31:11.668695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.914367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-28T12:31:11.668756Z","caller":"traceutil/trace.go:171","msg":"trace[260598555] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"126.001639ms","start":"2026-05-28T12:31:11.542742Z","end":"2026-05-28T12:31:11.668744Z","steps":["trace[260598555] 'agreement among raft nodes before linearized reading' (duration: 122.955524ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:31:11.669527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.683736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-28T12:31:11.669566Z","caller":"traceutil/trace.go:171","msg":"trace[367036324] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"100.744659ms","start":"2026-05-28T12:31:11.56881Z","end":"2026-05-28T12:31:11.669555Z","steps":["trace[367036324] 'agreement among raft nodes before linearized reading' (duration: 96.932379ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:31:49.124847Z","caller":"traceutil/trace.go:171","msg":"trace[1401944173] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"107.981492ms","start":"2026-05-28T12:31:49.016838Z","end":"2026-05-28T12:31:49.12482Z","steps":["trace[1401944173] 'process raft request' (duration: 107.815735ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:31:49.126676Z","caller":"traceutil/trace.go:171","msg":"trace[487225542] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"107.26239ms","start":"2026-05-28T12:31:49.019391Z","end":"2026-05-28T12:31:49.126654Z","steps":["trace[487225542] 'process raft request' (duration: 106.919585ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:31:55.617707Z","caller":"traceutil/trace.go:171","msg":"trace[1463180095] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"140.281484ms","start":"2026-05-28T12:31:55.477395Z","end":"2026-05-28T12:31:55.617677Z","steps":["trace[1463180095] 'process raft request' (duration: 140.081886ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:31:55.860224Z","caller":"traceutil/trace.go:171","msg":"trace[1154297822] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"280.071978ms","start":"2026-05-28T12:31:55.580121Z","end":"2026-05-28T12:31:55.860193Z","steps":["trace[1154297822] 'process raft request' (duration: 279.441102ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:31:56.592942Z","caller":"traceutil/trace.go:171","msg":"trace[497942623] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"405.710916ms","start":"2026-05-28T12:31:56.187195Z","end":"2026-05-28T12:31:56.592906Z","steps":["trace[497942623] 'read index received' (duration: 307.22443ms)","trace[497942623] 'applied index is now lower than readState.Index' (duration: 98.485436ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T12:31:56.593222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.005277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T12:31:56.593305Z","caller":"traceutil/trace.go:171","msg":"trace[1252845692] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:602; }","duration":"406.167705ms","start":"2026-05-28T12:31:56.187122Z","end":"2026-05-28T12:31:56.59329Z","steps":["trace[1252845692] 'agreement among raft nodes before linearized reading' (duration: 406.000298ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:31:56.593383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:31:56.18709Z","time spent":"406.280919ms","remote":"127.0.0.1:54818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-28T12:31:56.593261Z","caller":"traceutil/trace.go:171","msg":"trace[1904494641] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"671.573665ms","start":"2026-05-28T12:31:55.921616Z","end":"2026-05-28T12:31:56.593189Z","steps":["trace[1904494641] 'process raft request' (duration: 572.875999ms)","trace[1904494641] 'compare' (duration: 98.127633ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T12:31:56.594217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:31:55.921571Z","time spent":"671.97373ms","remote":"127.0.0.1:48552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T12:32:11.72741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.873121ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T12:32:11.727627Z","caller":"traceutil/trace.go:171","msg":"trace[1647730066] linearizableReadLoop","detail":"{readStateIndex:799; appliedIndex:797; }","duration":"212.42765ms","start":"2026-05-28T12:32:11.515177Z","end":"2026-05-28T12:32:11.727605Z","steps":["trace[1647730066] 'read index received' (duration: 53.840842ms)","trace[1647730066] 'applied index is now lower than readState.Index' (duration: 158.585568ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T12:32:11.727839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.664128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-rg6z5\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-28T12:32:11.727879Z","caller":"traceutil/trace.go:171","msg":"trace[660979902] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-rg6z5; range_end:; response_count:1; response_revision:764; }","duration":"212.75148ms","start":"2026-05-28T12:32:11.515115Z","end":"2026-05-28T12:32:11.727866Z","steps":["trace[660979902] 'agreement among raft nodes before linearized reading' (duration: 212.547412ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:32:11.727999Z","caller":"traceutil/trace.go:171","msg":"trace[657045060] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"463.050932ms","start":"2026-05-28T12:32:11.264896Z","end":"2026-05-28T12:32:11.727946Z","steps":["trace[657045060] 'process raft request' (duration: 462.644017ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:32:11.728053Z","caller":"traceutil/trace.go:171","msg":"trace[478902330] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"463.771789ms","start":"2026-05-28T12:32:11.264234Z","end":"2026-05-28T12:32:11.728006Z","steps":["trace[478902330] 'process raft request' (duration: 304.858099ms)","trace[478902330] 'compare' (duration: 157.715276ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T12:32:11.728251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:32:11.264202Z","time spent":"463.944104ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T12:32:11.728253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:32:11.264888Z","time spent":"463.223908ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T12:32:42.015083Z","caller":"traceutil/trace.go:171","msg":"trace[1595428695] linearizableReadLoop","detail":"{readStateIndex:1205; appliedIndex:1204; }","duration":"122.769982ms","start":"2026-05-28T12:32:41.892292Z","end":"2026-05-28T12:32:42.015062Z","steps":["trace[1595428695] 'read index received' (duration: 122.634367ms)","trace[1595428695] 'applied index is now lower than readState.Index' (duration: 134.765µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:32:42.015278Z","caller":"traceutil/trace.go:171","msg":"trace[1900983372] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"224.408669ms","start":"2026-05-28T12:32:41.79084Z","end":"2026-05-28T12:32:42.015248Z","steps":["trace[1900983372] 'process raft request' (duration: 224.072269ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:32:42.015345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.292909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-28T12:32:42.015379Z","caller":"traceutil/trace.go:171","msg":"trace[706178859] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1162; }","duration":"117.365061ms","start":"2026-05-28T12:32:41.898006Z","end":"2026-05-28T12:32:42.015371Z","steps":["trace[706178859] 'agreement among raft nodes before linearized reading' (duration: 117.190046ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:32:42.015614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.304578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-28T12:32:42.015726Z","caller":"traceutil/trace.go:171","msg":"trace[2060432642] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1162; }","duration":"123.440331ms","start":"2026-05-28T12:32:41.892238Z","end":"2026-05-28T12:32:42.015678Z","steps":["trace[2060432642] 'agreement among raft nodes before linearized reading' (duration: 123.057561ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:33:28.412223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.365591ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T12:33:28.412329Z","caller":"traceutil/trace.go:171","msg":"trace[149683147] linearizableReadLoop","detail":"{readStateIndex:1911; appliedIndex:1910; }","duration":"466.440534ms","start":"2026-05-28T12:33:27.945872Z","end":"2026-05-28T12:33:28.412313Z","steps":["trace[149683147] 'read index received' (duration: 335.861189ms)","trace[149683147] 'applied index is now lower than readState.Index' (duration: 130.578005ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:33:28.412563Z","caller":"traceutil/trace.go:171","msg":"trace[1195254859] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"483.599098ms","start":"2026-05-28T12:33:27.928936Z","end":"2026-05-28T12:33:28.412535Z","steps":["trace[1195254859] 'process raft request' (duration: 352.814067ms)","trace[1195254859] 'compare' (duration: 129.986911ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T12:33:28.412662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:33:27.928918Z","time spent":"483.702489ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T12:33:28.412923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.979586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4e81b681-8f7d-4159-9b00-5109bdfed337\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-28T12:33:28.413031Z","caller":"traceutil/trace.go:171","msg":"trace[983969892] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4e81b681-8f7d-4159-9b00-5109bdfed337; range_end:; response_count:1; response_revision:1830; }","duration":"467.137051ms","start":"2026-05-28T12:33:27.945866Z","end":"2026-05-28T12:33:28.413003Z","steps":["trace[983969892] 'agreement among raft nodes before linearized reading' (duration: 466.757821ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:33:28.413094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:33:27.945818Z","time spent":"467.262084ms","remote":"127.0.0.1:48294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4e81b681-8f7d-4159-9b00-5109bdfed337\" "} {"level":"info","ts":"2026-05-28T12:33:28.422542Z","caller":"traceutil/trace.go:171","msg":"trace[1316366232] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"474.388905ms","start":"2026-05-28T12:33:27.948142Z","end":"2026-05-28T12:33:28.422531Z","steps":["trace[1316366232] 'process raft request' (duration: 474.1837ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:33:28.422609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:33:27.94812Z","time spent":"474.456627ms","remote":"127.0.0.1:48280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T12:33:28.422747Z","caller":"traceutil/trace.go:171","msg":"trace[465515938] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"388.364315ms","start":"2026-05-28T12:33:28.034368Z","end":"2026-05-28T12:33:28.422732Z","steps":["trace[465515938] 'process raft request' (duration: 388.13721ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:33:28.422793Z","caller":"traceutil/trace.go:171","msg":"trace[38318993] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"472.93266ms","start":"2026-05-28T12:33:27.949846Z","end":"2026-05-28T12:33:28.422778Z","steps":["trace[38318993] 'process raft request' (duration: 472.634542ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:33:28.422771Z","caller":"traceutil/trace.go:171","msg":"trace[2005944251] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"473.525274ms","start":"2026-05-28T12:33:27.94922Z","end":"2026-05-28T12:33:28.422746Z","steps":["trace[2005944251] 'process raft request' (duration: 473.207127ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:33:28.422853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:33:28.034344Z","time spent":"388.456647ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T12:33:28.422859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:33:27.949837Z","time spent":"472.986791ms","remote":"127.0.0.1:48352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1529,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T12:33:28.423089Z","caller":"traceutil/trace.go:171","msg":"trace[1035173418] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"474.565138ms","start":"2026-05-28T12:33:27.948499Z","end":"2026-05-28T12:33:28.423064Z","steps":["trace[1035173418] 'process raft request' (duration: 473.889562ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:33:28.423132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:33:27.949213Z","time spent":"473.779471ms","remote":"127.0.0.1:48352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T12:33:28.42322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:33:27.948491Z","time spent":"474.66347ms","remote":"127.0.0.1:48280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T12:33:28.423238Z","caller":"traceutil/trace.go:171","msg":"trace[930707958] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"226.470387ms","start":"2026-05-28T12:33:28.196753Z","end":"2026-05-28T12:33:28.423224Z","steps":["trace[930707958] 'process raft request' (duration: 225.819032ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:33:28.423493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.445464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-28T12:33:28.423537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.757343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4e81b681-8f7d-4159-9b00-5109bdfed337\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-05-28T12:33:28.423591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.714744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T12:33:28.423625Z","caller":"traceutil/trace.go:171","msg":"trace[1351706299] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1836; }","duration":"236.786615ms","start":"2026-05-28T12:33:28.186832Z","end":"2026-05-28T12:33:28.423618Z","steps":["trace[1351706299] 'agreement among raft nodes before linearized reading' (duration: 236.725094ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:33:28.42362Z","caller":"traceutil/trace.go:171","msg":"trace[2125767269] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4e81b681-8f7d-4159-9b00-5109bdfed337; range_end:; response_count:1; response_revision:1836; }","duration":"378.891607ms","start":"2026-05-28T12:33:28.044709Z","end":"2026-05-28T12:33:28.4236Z","steps":["trace[2125767269] 'agreement among raft nodes before linearized reading' (duration: 378.699483ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:33:28.423667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:33:28.044685Z","time spent":"378.970669ms","remote":"127.0.0.1:48294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4e81b681-8f7d-4159-9b00-5109bdfed337\" "} {"level":"info","ts":"2026-05-28T12:33:28.42358Z","caller":"traceutil/trace.go:171","msg":"trace[1113782226] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1836; }","duration":"183.565296ms","start":"2026-05-28T12:33:28.240006Z","end":"2026-05-28T12:33:28.423572Z","steps":["trace[1113782226] 'agreement among raft nodes before linearized reading' (duration: 183.415843ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:33:28.423525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.007255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-28T12:33:28.423853Z","caller":"traceutil/trace.go:171","msg":"trace[642585905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1836; }","duration":"183.362142ms","start":"2026-05-28T12:33:28.240481Z","end":"2026-05-28T12:33:28.423843Z","steps":["trace[642585905] 'agreement among raft nodes before linearized reading' (duration: 182.933442ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:33:28.548685Z","caller":"traceutil/trace.go:171","msg":"trace[2028445432] linearizableReadLoop","detail":"{readStateIndex:1918; appliedIndex:1917; }","duration":"122.646645ms","start":"2026-05-28T12:33:28.42601Z","end":"2026-05-28T12:33:28.548657Z","steps":["trace[2028445432] 'read index received' (duration: 117.245125ms)","trace[2028445432] 'applied index is now lower than readState.Index' (duration: 5.40046ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T12:33:28.5488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.755858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T12:33:28.548703Z","caller":"traceutil/trace.go:171","msg":"trace[606201939] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"128.908876ms","start":"2026-05-28T12:33:28.419764Z","end":"2026-05-28T12:33:28.548672Z","steps":["trace[606201939] 'process raft request' (duration: 123.489965ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:33:28.548849Z","caller":"traceutil/trace.go:171","msg":"trace[929883143] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1837; }","duration":"122.85076ms","start":"2026-05-28T12:33:28.425987Z","end":"2026-05-28T12:33:28.548837Z","steps":["trace[929883143] 'agreement among raft nodes before linearized reading' (duration: 122.718297ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:33:28.575237Z","caller":"traceutil/trace.go:171","msg":"trace[1974197914] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"145.777459ms","start":"2026-05-28T12:33:28.42944Z","end":"2026-05-28T12:33:28.575218Z","steps":["trace[1974197914] 'process raft request' (duration: 145.688567ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:33:28.57525Z","caller":"traceutil/trace.go:171","msg":"trace[1916563858] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"145.948634ms","start":"2026-05-28T12:33:28.429265Z","end":"2026-05-28T12:33:28.575214Z","steps":["trace[1916563858] 'process raft request' (duration: 145.727929ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:33:28.575307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.148685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-28T12:33:28.575357Z","caller":"traceutil/trace.go:171","msg":"trace[589886277] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1839; }","duration":"120.245686ms","start":"2026-05-28T12:33:28.455099Z","end":"2026-05-28T12:33:28.575344Z","steps":["trace[589886277] 'agreement among raft nodes before linearized reading' (duration: 120.069493ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:33:28.946221Z","caller":"traceutil/trace.go:171","msg":"trace[765108877] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"366.460509ms","start":"2026-05-28T12:33:28.579732Z","end":"2026-05-28T12:33:28.946192Z","steps":["trace[765108877] 'process raft request' (duration: 290.586837ms)","trace[765108877] 'compare' (duration: 75.692168ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T12:33:28.946409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:33:28.579716Z","time spent":"366.580732ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T12:33:40.566284Z","caller":"traceutil/trace.go:171","msg":"trace[1928376765] transaction","detail":"{read_only:false; response_revision:1938; number_of_response:1; }","duration":"107.71201ms","start":"2026-05-28T12:33:40.458523Z","end":"2026-05-28T12:33:40.566235Z","steps":["trace[1928376765] 'process raft request' (duration: 88.749032ms)","trace[1928376765] 'compare' (duration: 18.743513ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:33:42.712938Z","caller":"traceutil/trace.go:171","msg":"trace[2043257124] transaction","detail":"{read_only:false; response_revision:1948; number_of_response:1; }","duration":"182.201619ms","start":"2026-05-28T12:33:42.530711Z","end":"2026-05-28T12:33:42.712913Z","steps":["trace[2043257124] 'process raft request' (duration: 181.870701ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:33:42.79828Z","caller":"traceutil/trace.go:171","msg":"trace[1563467420] transaction","detail":"{read_only:false; response_revision:1949; number_of_response:1; }","duration":"225.622966ms","start":"2026-05-28T12:33:42.572644Z","end":"2026-05-28T12:33:42.798267Z","steps":["trace[1563467420] 'process raft request' (duration: 225.442961ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:33:42.79832Z","caller":"traceutil/trace.go:171","msg":"trace[592290455] transaction","detail":"{read_only:false; response_revision:1950; number_of_response:1; }","duration":"225.604556ms","start":"2026-05-28T12:33:42.5727Z","end":"2026-05-28T12:33:42.798305Z","steps":["trace[592290455] 'process raft request' (duration: 225.498484ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:33:42.798247Z","caller":"traceutil/trace.go:171","msg":"trace[45194651] linearizableReadLoop","detail":"{readStateIndex:2034; appliedIndex:2031; }","duration":"219.671788ms","start":"2026-05-28T12:33:42.578557Z","end":"2026-05-28T12:33:42.798229Z","steps":["trace[45194651] 'read index received' (duration: 134.217845ms)","trace[45194651] 'applied index is now lower than readState.Index' (duration: 85.451413ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T12:33:42.798536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.623137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-28T12:33:42.798563Z","caller":"traceutil/trace.go:171","msg":"trace[15051063] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1950; }","duration":"155.689548ms","start":"2026-05-28T12:33:42.642867Z","end":"2026-05-28T12:33:42.798556Z","steps":["trace[15051063] 'agreement among raft nodes before linearized reading' (duration: 155.572745ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:33:42.798562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.981586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-28T12:33:42.798634Z","caller":"traceutil/trace.go:171","msg":"trace[1472654129] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1950; }","duration":"220.093739ms","start":"2026-05-28T12:33:42.578522Z","end":"2026-05-28T12:33:42.798616Z","steps":["trace[1472654129] 'agreement among raft nodes before linearized reading' (duration: 219.863354ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:33:42.798594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.23754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-28T12:33:42.798807Z","caller":"traceutil/trace.go:171","msg":"trace[855991316] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1950; }","duration":"152.483575ms","start":"2026-05-28T12:33:42.646304Z","end":"2026-05-28T12:33:42.798788Z","steps":["trace[855991316] 'agreement among raft nodes before linearized reading' (duration: 152.139296ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:34:03.22109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.431049ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T12:34:03.221379Z","caller":"traceutil/trace.go:171","msg":"trace[1243804196] linearizableReadLoop","detail":"{readStateIndex:2161; appliedIndex:2159; }","duration":"346.399373ms","start":"2026-05-28T12:34:02.874966Z","end":"2026-05-28T12:34:03.221366Z","steps":["trace[1243804196] 'read index received' (duration: 175.558927ms)","trace[1243804196] 'applied index is now lower than readState.Index' (duration: 170.839786ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:34:03.221445Z","caller":"traceutil/trace.go:171","msg":"trace[1416206725] transaction","detail":"{read_only:false; response_revision:2073; number_of_response:1; }","duration":"358.914148ms","start":"2026-05-28T12:34:02.862505Z","end":"2026-05-28T12:34:03.221419Z","steps":["trace[1416206725] 'process raft request' (duration: 358.780475ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:34:03.221473Z","caller":"traceutil/trace.go:171","msg":"trace[1754984797] transaction","detail":"{read_only:false; response_revision:2072; number_of_response:1; }","duration":"360.41425ms","start":"2026-05-28T12:34:02.861027Z","end":"2026-05-28T12:34:03.221441Z","steps":["trace[1754984797] 'process raft request' (duration: 189.555603ms)","trace[1754984797] 'compare' (duration: 169.834915ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T12:34:03.221497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.533906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-28T12:34:03.221558Z","caller":"traceutil/trace.go:171","msg":"trace[37002198] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:2073; }","duration":"346.62753ms","start":"2026-05-28T12:34:02.874922Z","end":"2026-05-28T12:34:03.22155Z","steps":["trace[37002198] 'agreement among raft nodes before linearized reading' (duration: 346.540277ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:34:03.221615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:34:02.861004Z","time spent":"360.525343ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T12:34:03.221631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:34:02.862481Z","time spent":"359.0418ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T12:34:03.221646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.783304ms","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-05-28T12:34:03.221618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:34:02.87491Z","time spent":"346.698061ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":31,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"info","ts":"2026-05-28T12:34:03.221727Z","caller":"traceutil/trace.go:171","msg":"trace[1471922285] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2073; }","duration":"320.930788ms","start":"2026-05-28T12:34:02.900775Z","end":"2026-05-28T12:34:03.221706Z","steps":["trace[1471922285] 'agreement among raft nodes before linearized reading' (duration: 320.711373ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:34:03.221775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:34:02.90076Z","time spent":"321.005649ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-28T12:34:03.221891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.845568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-28T12:34:03.221946Z","caller":"traceutil/trace.go:171","msg":"trace[1822921901] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2073; }","duration":"121.945321ms","start":"2026-05-28T12:34:03.099986Z","end":"2026-05-28T12:34:03.221932Z","steps":["trace[1822921901] 'agreement among raft nodes before linearized reading' (duration: 121.766127ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:34:03.221959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.155569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-28T12:34:03.221996Z","caller":"traceutil/trace.go:171","msg":"trace[340512998] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2073; }","duration":"271.188549ms","start":"2026-05-28T12:34:02.950794Z","end":"2026-05-28T12:34:03.221983Z","steps":["trace[340512998] 'agreement among raft nodes before linearized reading' (duration: 271.081147ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:34:03.222102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.214486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-28T12:34:03.222197Z","caller":"traceutil/trace.go:171","msg":"trace[63356020] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2073; }","duration":"317.358349ms","start":"2026-05-28T12:34:02.904816Z","end":"2026-05-28T12:34:03.222174Z","steps":["trace[63356020] 'agreement among raft nodes before linearized reading' (duration: 317.070943ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:34:03.222265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:34:02.904806Z","time spent":"317.440321ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-28T12:34:03.57118Z","caller":"traceutil/trace.go:171","msg":"trace[1954775411] transaction","detail":"{read_only:false; response_revision:2077; number_of_response:1; }","duration":"176.145393ms","start":"2026-05-28T12:34:03.395005Z","end":"2026-05-28T12:34:03.57115Z","steps":["trace[1954775411] 'process raft request' (duration: 176.086162ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:34:03.571321Z","caller":"traceutil/trace.go:171","msg":"trace[2011797373] transaction","detail":"{read_only:false; response_revision:2076; number_of_response:1; }","duration":"344.182529ms","start":"2026-05-28T12:34:03.227072Z","end":"2026-05-28T12:34:03.571255Z","steps":["trace[2011797373] 'process raft request' (duration: 343.785411ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:34:03.571516Z","caller":"traceutil/trace.go:171","msg":"trace[1193811629] transaction","detail":"{read_only:false; response_revision:2075; number_of_response:1; }","duration":"344.526136ms","start":"2026-05-28T12:34:03.226424Z","end":"2026-05-28T12:34:03.570951Z","steps":["trace[1193811629] 'process raft request' (duration: 341.221935ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:34:03.571637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:34:03.227062Z","time spent":"344.469665ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T12:34:03.571724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:34:03.226416Z","time spent":"345.218583ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T12:35:32.213424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.333982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-28T12:35:32.213514Z","caller":"traceutil/trace.go:171","msg":"trace[1183482801] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2664; }","duration":"146.466435ms","start":"2026-05-28T12:35:32.067029Z","end":"2026-05-28T12:35:32.213495Z","steps":["trace[1183482801] 'range keys from in-memory index tree' (duration: 146.118839ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:35:32.213742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.12186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18b3bad63f504e07\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-05-28T12:35:32.213805Z","caller":"traceutil/trace.go:171","msg":"trace[1238946837] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18b3bad63f504e07; range_end:; response_count:1; response_revision:2664; }","duration":"121.226662ms","start":"2026-05-28T12:35:32.092564Z","end":"2026-05-28T12:35:32.213791Z","steps":["trace[1238946837] 'range keys from in-memory index tree' (duration: 120.875075ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:35:32.214076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.838425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-28T12:35:32.214128Z","caller":"traceutil/trace.go:171","msg":"trace[2081415530] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2664; }","duration":"189.931067ms","start":"2026-05-28T12:35:32.024183Z","end":"2026-05-28T12:35:32.214114Z","steps":["trace[2081415530] 'range keys from in-memory index tree' (duration: 189.711263ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:35:32.214229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.354015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-28T12:35:32.214252Z","caller":"traceutil/trace.go:171","msg":"trace[1101547358] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2664; }","duration":"189.413176ms","start":"2026-05-28T12:35:32.024834Z","end":"2026-05-28T12:35:32.214247Z","steps":["trace[1101547358] 'range keys from in-memory index tree' (duration: 189.230963ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:35:32.594069Z","caller":"traceutil/trace.go:171","msg":"trace[1524704709] linearizableReadLoop","detail":"{readStateIndex:2774; appliedIndex:2773; }","duration":"377.860244ms","start":"2026-05-28T12:35:32.216186Z","end":"2026-05-28T12:35:32.594047Z","steps":["trace[1524704709] 'read index received' (duration: 377.690661ms)","trace[1524704709] 'applied index is now lower than readState.Index' (duration: 168.583µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:35:32.59415Z","caller":"traceutil/trace.go:171","msg":"trace[1668785582] transaction","detail":"{read_only:false; response_revision:2665; number_of_response:1; }","duration":"378.595249ms","start":"2026-05-28T12:35:32.215518Z","end":"2026-05-28T12:35:32.594113Z","steps":["trace[1668785582] 'process raft request' (duration: 378.349263ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:35:32.594294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.090599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T12:35:32.594354Z","caller":"traceutil/trace.go:171","msg":"trace[1427384633] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2665; }","duration":"378.17683ms","start":"2026-05-28T12:35:32.216161Z","end":"2026-05-28T12:35:32.594338Z","steps":["trace[1427384633] 'agreement among raft nodes before linearized reading' (duration: 377.983306ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:35:32.594389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:35:32.21614Z","time spent":"378.242072ms","remote":"127.0.0.1:54828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-28T12:35:32.594522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:35:32.2155Z","time spent":"378.727211ms","remote":"127.0.0.1:48176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":766,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T12:35:32.614061Z","caller":"traceutil/trace.go:171","msg":"trace[2111336678] transaction","detail":"{read_only:false; response_revision:2667; number_of_response:1; }","duration":"396.555191ms","start":"2026-05-28T12:35:32.217487Z","end":"2026-05-28T12:35:32.614042Z","steps":["trace[2111336678] 'process raft request' (duration: 396.50244ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:35:32.614185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:35:32.217474Z","time spent":"396.643382ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T12:35:32.614261Z","caller":"traceutil/trace.go:171","msg":"trace[1278947543] transaction","detail":"{read_only:false; response_revision:2666; number_of_response:1; }","duration":"397.634081ms","start":"2026-05-28T12:35:32.216609Z","end":"2026-05-28T12:35:32.614243Z","steps":["trace[1278947543] 'process raft request' (duration: 397.268185ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:35:32.614359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:35:32.216598Z","time spent":"397.711033ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T12:35:32.614614Z","caller":"traceutil/trace.go:171","msg":"trace[238319002] transaction","detail":"{read_only:false; response_revision:2668; number_of_response:1; }","duration":"396.974408ms","start":"2026-05-28T12:35:32.217617Z","end":"2026-05-28T12:35:32.614592Z","steps":["trace[238319002] 'process raft request' (duration: 396.393986ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:35:32.614664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.552424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-28T12:35:32.614756Z","caller":"traceutil/trace.go:171","msg":"trace[1391513778] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2669; }","duration":"246.680437ms","start":"2026-05-28T12:35:32.368061Z","end":"2026-05-28T12:35:32.614742Z","steps":["trace[1391513778] 'agreement among raft nodes before linearized reading' (duration: 246.494673ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:35:32.614826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:35:32.217574Z","time spent":"397.094261ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T12:35:32.614636Z","caller":"traceutil/trace.go:171","msg":"trace[428627265] transaction","detail":"{read_only:false; response_revision:2669; number_of_response:1; }","duration":"388.685486ms","start":"2026-05-28T12:35:32.225936Z","end":"2026-05-28T12:35:32.614621Z","steps":["trace[428627265] 'process raft request' (duration: 388.460402ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:35:32.615119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:35:32.225927Z","time spent":"389.116364ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T12:39:14.66537Z","caller":"traceutil/trace.go:171","msg":"trace[860143157] transaction","detail":"{read_only:false; response_revision:4553; number_of_response:1; }","duration":"155.894163ms","start":"2026-05-28T12:39:14.509445Z","end":"2026-05-28T12:39:14.665339Z","steps":["trace[860143157] 'process raft request' (duration: 155.74851ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:39:14.673052Z","caller":"traceutil/trace.go:171","msg":"trace[593547319] transaction","detail":"{read_only:false; response_revision:4554; number_of_response:1; }","duration":"157.265149ms","start":"2026-05-28T12:39:14.515769Z","end":"2026-05-28T12:39:14.673034Z","steps":["trace[593547319] 'process raft request' (duration: 157.156966ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:20.535713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.063146ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T12:39:20.535874Z","caller":"traceutil/trace.go:171","msg":"trace[935721313] transaction","detail":"{read_only:false; response_revision:4654; number_of_response:1; }","duration":"527.293541ms","start":"2026-05-28T12:39:20.008562Z","end":"2026-05-28T12:39:20.535856Z","steps":["trace[935721313] 'process raft request' (duration: 352.002869ms)","trace[935721313] 'compare' (duration: 174.967414ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T12:39:20.535989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:20.00855Z","time spent":"527.410654ms","remote":"127.0.0.1:48176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":725,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T12:39:20.53605Z","caller":"traceutil/trace.go:171","msg":"trace[1264697850] linearizableReadLoop","detail":"{readStateIndex:4838; appliedIndex:4837; }","duration":"526.48616ms","start":"2026-05-28T12:39:20.009538Z","end":"2026-05-28T12:39:20.536024Z","steps":["trace[1264697850] 'read index received' (duration: 351.035925ms)","trace[1264697850] 'applied index is now lower than readState.Index' (duration: 175.448695ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:39:20.536123Z","caller":"traceutil/trace.go:171","msg":"trace[1298101997] transaction","detail":"{read_only:false; response_revision:4655; number_of_response:1; }","duration":"515.362911ms","start":"2026-05-28T12:39:20.020739Z","end":"2026-05-28T12:39:20.536102Z","steps":["trace[1298101997] 'process raft request' (duration: 515.057244ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:20.536242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:20.020721Z","time spent":"515.461273ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T12:39:20.536274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.726627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1451"} {"level":"info","ts":"2026-05-28T12:39:20.536314Z","caller":"traceutil/trace.go:171","msg":"trace[1125961013] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4655; }","duration":"526.807608ms","start":"2026-05-28T12:39:20.009493Z","end":"2026-05-28T12:39:20.536301Z","steps":["trace[1125961013] 'agreement among raft nodes before linearized reading' (duration: 526.647594ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:20.536354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:20.00946Z","time spent":"526.884542ms","remote":"127.0.0.1:48266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1475,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-05-28T12:39:20.536533Z","caller":"traceutil/trace.go:171","msg":"trace[578259570] transaction","detail":"{read_only:false; response_revision:4656; number_of_response:1; }","duration":"204.957356ms","start":"2026-05-28T12:39:20.331566Z","end":"2026-05-28T12:39:20.536523Z","steps":["trace[578259570] 'process raft request' (duration: 204.447424ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:39:20.536617Z","caller":"traceutil/trace.go:171","msg":"trace[65296118] transaction","detail":"{read_only:false; response_revision:4657; number_of_response:1; }","duration":"185.123619ms","start":"2026-05-28T12:39:20.351487Z","end":"2026-05-28T12:39:20.536611Z","steps":["trace[65296118] 'process raft request' (duration: 185.003286ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:20.547414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.834092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"warn","ts":"2026-05-28T12:39:20.547467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.22796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206973"} {"level":"info","ts":"2026-05-28T12:39:20.547509Z","caller":"traceutil/trace.go:171","msg":"trace[1733045978] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4658; }","duration":"331.972356ms","start":"2026-05-28T12:39:20.215521Z","end":"2026-05-28T12:39:20.547493Z","steps":["trace[1733045978] 'agreement among raft nodes before linearized reading' (duration: 331.72034ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:39:20.54753Z","caller":"traceutil/trace.go:171","msg":"trace[159259755] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4658; }","duration":"451.328792ms","start":"2026-05-28T12:39:20.096187Z","end":"2026-05-28T12:39:20.547516Z","steps":["trace[159259755] 'agreement among raft nodes before linearized reading' (duration: 450.520172ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:20.547559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:20.09617Z","time spent":"451.381945ms","remote":"127.0.0.1:48206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2206997,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"warn","ts":"2026-05-28T12:39:20.547554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:20.215504Z","time spent":"332.038999ms","remote":"127.0.0.1:48300","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":921,"request content":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" "} {"level":"warn","ts":"2026-05-28T12:39:21.122053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.990654ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T12:39:21.122229Z","caller":"traceutil/trace.go:171","msg":"trace[1416727459] transaction","detail":"{read_only:false; response_revision:4673; number_of_response:1; }","duration":"240.712171ms","start":"2026-05-28T12:39:20.881501Z","end":"2026-05-28T12:39:21.122214Z","steps":["trace[1416727459] 'process raft request' (duration: 240.639369ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:39:21.12222Z","caller":"traceutil/trace.go:171","msg":"trace[332796515] transaction","detail":"{read_only:false; response_revision:4672; number_of_response:1; }","duration":"353.847381ms","start":"2026-05-28T12:39:20.768335Z","end":"2026-05-28T12:39:21.122182Z","steps":["trace[332796515] 'process raft request' (duration: 95.637611ms)","trace[332796515] 'compare' (duration: 257.314008ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T12:39:21.122402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:20.768305Z","time spent":"354.011776ms","remote":"127.0.0.1:48176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":725,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T12:39:21.122437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.491007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-05-28T12:39:21.122488Z","caller":"traceutil/trace.go:171","msg":"trace[694747152] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4673; }","duration":"352.57732ms","start":"2026-05-28T12:39:20.769902Z","end":"2026-05-28T12:39:21.12248Z","steps":["trace[694747152] 'agreement among raft nodes before linearized reading' (duration: 352.376375ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:39:21.122241Z","caller":"traceutil/trace.go:171","msg":"trace[1105874218] linearizableReadLoop","detail":"{readStateIndex:4856; appliedIndex:4855; }","duration":"352.293832ms","start":"2026-05-28T12:39:20.769928Z","end":"2026-05-28T12:39:21.122222Z","steps":["trace[1105874218] 'read index received' (duration: 93.919948ms)","trace[1105874218] 'applied index is now lower than readState.Index' (duration: 258.372424ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T12:39:21.122522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:20.76989Z","time spent":"352.624352ms","remote":"127.0.0.1:48202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":720,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" "} {"level":"warn","ts":"2026-05-28T12:39:21.122679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.313441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2807fb2f-dc2d-4778-a1e4-ae74425c9bf3\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-28T12:39:21.122709Z","caller":"traceutil/trace.go:171","msg":"trace[973536006] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2807fb2f-dc2d-4778-a1e4-ae74425c9bf3; range_end:; response_count:1; response_revision:4673; }","duration":"195.370132ms","start":"2026-05-28T12:39:20.927329Z","end":"2026-05-28T12:39:21.122699Z","steps":["trace[973536006] 'agreement among raft nodes before linearized reading' (duration: 195.255569ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:21.122715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.6037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"warn","ts":"2026-05-28T12:39:21.122756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.123849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-28T12:39:21.122768Z","caller":"traceutil/trace.go:171","msg":"trace[1465060349] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4673; }","duration":"344.681612ms","start":"2026-05-28T12:39:20.778074Z","end":"2026-05-28T12:39:21.122756Z","steps":["trace[1465060349] 'agreement among raft nodes before linearized reading' (duration: 344.507417ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:21.122798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:20.778048Z","time spent":"344.744603ms","remote":"127.0.0.1:48500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":9663,"request content":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" "} {"level":"info","ts":"2026-05-28T12:39:21.122813Z","caller":"traceutil/trace.go:171","msg":"trace[1460651423] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4673; }","duration":"219.19708ms","start":"2026-05-28T12:39:20.903588Z","end":"2026-05-28T12:39:21.122785Z","steps":["trace[1460651423] 'agreement among raft nodes before linearized reading' (duration: 219.043287ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:39:21.502801Z","caller":"traceutil/trace.go:171","msg":"trace[473615637] linearizableReadLoop","detail":"{readStateIndex:4859; appliedIndex:4857; }","duration":"374.918464ms","start":"2026-05-28T12:39:21.12786Z","end":"2026-05-28T12:39:21.502778Z","steps":["trace[473615637] 'read index received' (duration: 88.618033ms)","trace[473615637] 'applied index is now lower than readState.Index' (duration: 286.299741ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:39:21.502888Z","caller":"traceutil/trace.go:171","msg":"trace[1747973212] transaction","detail":"{read_only:false; response_revision:4675; number_of_response:1; }","duration":"375.153758ms","start":"2026-05-28T12:39:21.127693Z","end":"2026-05-28T12:39:21.502846Z","steps":["trace[1747973212] 'process raft request' (duration: 374.945953ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:21.503025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.133089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-05-28T12:39:21.503061Z","caller":"traceutil/trace.go:171","msg":"trace[1998180881] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4675; }","duration":"375.229001ms","start":"2026-05-28T12:39:21.127823Z","end":"2026-05-28T12:39:21.503052Z","steps":["trace[1998180881] 'agreement among raft nodes before linearized reading' (duration: 375.084597ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:21.503057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:21.127674Z","time spent":"375.288772ms","remote":"127.0.0.1:48176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":736,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T12:39:21.503088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:21.127804Z","time spent":"375.278261ms","remote":"127.0.0.1:48202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":720,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" "} {"level":"warn","ts":"2026-05-28T12:39:21.792901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.661562ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-28T12:39:21.793025Z","caller":"traceutil/trace.go:171","msg":"trace[1974220469] linearizableReadLoop","detail":"{readStateIndex:4860; appliedIndex:4859; }","duration":"290.119446ms","start":"2026-05-28T12:39:21.502878Z","end":"2026-05-28T12:39:21.792998Z","steps":["trace[1974220469] 'read index received' (duration: 158.227769ms)","trace[1974220469] 'applied index is now lower than readState.Index' (duration: 131.890267ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T12:39:21.793205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.954893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-28T12:39:21.793277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.662518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-05-28T12:39:21.793329Z","caller":"traceutil/trace.go:171","msg":"trace[1257543207] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4676; }","duration":"457.73935ms","start":"2026-05-28T12:39:21.335568Z","end":"2026-05-28T12:39:21.793307Z","steps":["trace[1257543207] 'agreement among raft nodes before linearized reading' (duration: 457.544415ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:21.793343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.522617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-28T12:39:21.793375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:21.335548Z","time spent":"457.816472ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":554,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"info","ts":"2026-05-28T12:39:21.793403Z","caller":"traceutil/trace.go:171","msg":"trace[1223866352] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4676; }","duration":"369.64163ms","start":"2026-05-28T12:39:21.42375Z","end":"2026-05-28T12:39:21.793391Z","steps":["trace[1223866352] 'agreement among raft nodes before linearized reading' (duration: 369.516687ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:39:21.793205Z","caller":"traceutil/trace.go:171","msg":"trace[10040612] transaction","detail":"{read_only:false; response_revision:4676; number_of_response:1; }","duration":"376.723918ms","start":"2026-05-28T12:39:21.416444Z","end":"2026-05-28T12:39:21.793168Z","steps":["trace[10040612] 'process raft request' (duration: 244.720987ms)","trace[10040612] 'compare' (duration: 131.458207ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T12:39:21.793543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:21.416416Z","time spent":"377.069697ms","remote":"127.0.0.1:49056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2228,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T12:39:21.793625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.286921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-28T12:39:21.793624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.316657ms","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-05-28T12:39:21.793711Z","caller":"traceutil/trace.go:171","msg":"trace[1745174806] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4676; }","duration":"607.413275ms","start":"2026-05-28T12:39:21.186255Z","end":"2026-05-28T12:39:21.793668Z","steps":["trace[1745174806] 'agreement among raft nodes before linearized reading' (duration: 607.283451ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:39:21.793699Z","caller":"traceutil/trace.go:171","msg":"trace[1928316185] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:4676; }","duration":"549.469681ms","start":"2026-05-28T12:39:21.244212Z","end":"2026-05-28T12:39:21.793682Z","steps":["trace[1928316185] 'agreement among raft nodes before linearized reading' (duration: 549.304886ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:21.793767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:21.244188Z","time spent":"549.566003ms","remote":"127.0.0.1:44604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-28T12:39:21.793784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:21.186238Z","time spent":"607.508207ms","remote":"127.0.0.1:54818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-28T12:39:21.793342Z","caller":"traceutil/trace.go:171","msg":"trace[803766568] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:4676; }","duration":"428.123477ms","start":"2026-05-28T12:39:21.365172Z","end":"2026-05-28T12:39:21.793295Z","steps":["trace[803766568] 'agreement among raft nodes before linearized reading' (duration: 427.922682ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:21.793892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:21.365145Z","time spent":"428.728772ms","remote":"127.0.0.1:41314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true "} {"level":"warn","ts":"2026-05-28T12:39:21.794014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.645941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-28T12:39:21.79406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.990659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T12:39:21.794072Z","caller":"traceutil/trace.go:171","msg":"trace[1148505982] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:4676; }","duration":"113.750743ms","start":"2026-05-28T12:39:21.680308Z","end":"2026-05-28T12:39:21.794058Z","steps":["trace[1148505982] 'agreement among raft nodes before linearized reading' (duration: 113.66123ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:39:21.794106Z","caller":"traceutil/trace.go:171","msg":"trace[493959104] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:4676; }","duration":"104.05118ms","start":"2026-05-28T12:39:21.69004Z","end":"2026-05-28T12:39:21.794092Z","steps":["trace[493959104] 'agreement among raft nodes before linearized reading' (duration: 103.969418ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:21.794195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.92371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-28T12:39:21.794245Z","caller":"traceutil/trace.go:171","msg":"trace[1894745795] 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:4676; }","duration":"217.011543ms","start":"2026-05-28T12:39:21.577221Z","end":"2026-05-28T12:39:21.794232Z","steps":["trace[1894745795] 'agreement among raft nodes before linearized reading' (duration: 216.864398ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:21.793449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:21.423733Z","time spent":"369.705011ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-05-28T12:39:21.793677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.84594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-05-28T12:39:21.794406Z","caller":"traceutil/trace.go:171","msg":"trace[730124013] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4676; }","duration":"288.612068ms","start":"2026-05-28T12:39:21.505784Z","end":"2026-05-28T12:39:21.794396Z","steps":["trace[730124013] 'agreement among raft nodes before linearized reading' (duration: 287.714546ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:39:22.175871Z","caller":"traceutil/trace.go:171","msg":"trace[397860881] transaction","detail":"{read_only:false; response_revision:4678; number_of_response:1; }","duration":"304.03185ms","start":"2026-05-28T12:39:21.871818Z","end":"2026-05-28T12:39:22.17585Z","steps":["trace[397860881] 'process raft request' (duration: 303.893597ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:22.176016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:21.871807Z","time spent":"304.131712ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T12:39:22.194517Z","caller":"traceutil/trace.go:171","msg":"trace[2072552838] transaction","detail":"{read_only:false; response_revision:4679; number_of_response:1; }","duration":"320.749058ms","start":"2026-05-28T12:39:21.873747Z","end":"2026-05-28T12:39:22.194496Z","steps":["trace[2072552838] 'process raft request' (duration: 318.4087ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:22.194653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:21.873732Z","time spent":"320.848641ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T12:39:22.194901Z","caller":"traceutil/trace.go:171","msg":"trace[1001318896] linearizableReadLoop","detail":"{readStateIndex:4864; appliedIndex:4861; }","duration":"316.030161ms","start":"2026-05-28T12:39:21.87884Z","end":"2026-05-28T12:39:22.19487Z","steps":["trace[1001318896] 'read index received' (duration: 296.982894ms)","trace[1001318896] 'applied index is now lower than readState.Index' (duration: 19.045697ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:39:22.194946Z","caller":"traceutil/trace.go:171","msg":"trace[1701590996] transaction","detail":"{read_only:false; response_revision:4680; number_of_response:1; }","duration":"316.666086ms","start":"2026-05-28T12:39:21.878238Z","end":"2026-05-28T12:39:22.194904Z","steps":["trace[1701590996] 'process raft request' (duration: 316.201745ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:22.195194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.329618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-28T12:39:22.195241Z","caller":"traceutil/trace.go:171","msg":"trace[867800335] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4680; }","duration":"316.41919ms","start":"2026-05-28T12:39:21.878809Z","end":"2026-05-28T12:39:22.195228Z","steps":["trace[867800335] 'agreement among raft nodes before linearized reading' (duration: 316.222035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:22.195268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:21.878229Z","time spent":"316.868451ms","remote":"127.0.0.1:47108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7495,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T12:39:22.195286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:21.878787Z","time spent":"316.486322ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-28T12:39:22.195451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.337296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-28T12:39:22.19771Z","caller":"traceutil/trace.go:171","msg":"trace[1308324507] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4680; }","duration":"298.445939ms","start":"2026-05-28T12:39:21.897044Z","end":"2026-05-28T12:39:22.19549Z","steps":["trace[1308324507] 'agreement among raft nodes before linearized reading' (duration: 298.116421ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:22.197842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:21.89703Z","time spent":"300.770498ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-28T12:39:34.691256Z","caller":"traceutil/trace.go:171","msg":"trace[1778913192] transaction","detail":"{read_only:false; response_revision:4835; number_of_response:1; }","duration":"106.741426ms","start":"2026-05-28T12:39:34.584487Z","end":"2026-05-28T12:39:34.691228Z","steps":["trace[1778913192] 'process raft request' (duration: 106.452369ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:35.332127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.470399ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T12:39:35.332626Z","caller":"traceutil/trace.go:171","msg":"trace[2063525492] linearizableReadLoop","detail":"{readStateIndex:5027; appliedIndex:5024; }","duration":"735.246062ms","start":"2026-05-28T12:39:34.597361Z","end":"2026-05-28T12:39:35.332607Z","steps":["trace[2063525492] 'read index received' (duration: 93.469308ms)","trace[2063525492] 'applied index is now lower than readState.Index' (duration: 641.775654ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:39:35.332786Z","caller":"traceutil/trace.go:171","msg":"trace[1514922098] transaction","detail":"{read_only:false; response_revision:4836; number_of_response:1; }","duration":"745.562527ms","start":"2026-05-28T12:39:34.587197Z","end":"2026-05-28T12:39:35.332759Z","steps":["trace[1514922098] 'process raft request' (duration: 400.38028ms)","trace[1514922098] 'compare' (duration: 344.271525ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:39:35.332805Z","caller":"traceutil/trace.go:171","msg":"trace[1949120119] transaction","detail":"{read_only:false; response_revision:4837; number_of_response:1; }","duration":"742.114552ms","start":"2026-05-28T12:39:34.590649Z","end":"2026-05-28T12:39:35.332763Z","steps":["trace[1949120119] 'process raft request' (duration: 741.887456ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:35.333002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:34.590618Z","time spent":"742.294706ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T12:39:35.333052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:34.587184Z","time spent":"745.6698ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T12:39:35.333363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.775926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-05-28T12:39:35.333691Z","caller":"traceutil/trace.go:171","msg":"trace[373206041] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:4837; }","duration":"736.34924ms","start":"2026-05-28T12:39:34.597325Z","end":"2026-05-28T12:39:35.333674Z","steps":["trace[373206041] 'agreement among raft nodes before linearized reading' (duration: 735.415186ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:35.333848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:34.597312Z","time spent":"736.459442ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"info","ts":"2026-05-28T12:39:35.334431Z","caller":"traceutil/trace.go:171","msg":"trace[1366400217] transaction","detail":"{read_only:false; response_revision:4838; number_of_response:1; }","duration":"145.926251ms","start":"2026-05-28T12:39:35.188482Z","end":"2026-05-28T12:39:35.334408Z","steps":["trace[1366400217] 'process raft request' (duration: 145.724977ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:35.334455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.518243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T12:39:35.334511Z","caller":"traceutil/trace.go:171","msg":"trace[172595743] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:4838; }","duration":"338.610145ms","start":"2026-05-28T12:39:34.995886Z","end":"2026-05-28T12:39:35.334496Z","steps":["trace[172595743] 'agreement among raft nodes before linearized reading' (duration: 338.502623ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:35.334558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:34.995871Z","time spent":"338.677107ms","remote":"127.0.0.1:44706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-05-28T12:39:35.334736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.980654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-28T12:39:35.334769Z","caller":"traceutil/trace.go:171","msg":"trace[500359588] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:4838; }","duration":"215.060936ms","start":"2026-05-28T12:39:35.119699Z","end":"2026-05-28T12:39:35.33476Z","steps":["trace[500359588] 'agreement among raft nodes before linearized reading' (duration: 214.981974ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:35.334983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.642571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-05-28T12:39:35.335006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.632651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-05-28T12:39:35.335027Z","caller":"traceutil/trace.go:171","msg":"trace[1448598595] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4838; }","duration":"490.725232ms","start":"2026-05-28T12:39:34.844291Z","end":"2026-05-28T12:39:35.335017Z","steps":["trace[1448598595] 'agreement among raft nodes before linearized reading' (duration: 490.561009ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:39:35.33504Z","caller":"traceutil/trace.go:171","msg":"trace[1326927557] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4838; }","duration":"437.701543ms","start":"2026-05-28T12:39:34.897332Z","end":"2026-05-28T12:39:35.335033Z","steps":["trace[1326927557] 'agreement among raft nodes before linearized reading' (duration: 437.59772ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:35.33506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:34.897312Z","time spent":"437.743583ms","remote":"127.0.0.1:41466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3340,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"warn","ts":"2026-05-28T12:39:35.335059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:34.84427Z","time spent":"490.781984ms","remote":"127.0.0.1:48294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-05-28T12:39:35.335273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.350006ms","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-05-28T12:39:35.3353Z","caller":"traceutil/trace.go:171","msg":"trace[29415108] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4838; }","duration":"576.40657ms","start":"2026-05-28T12:39:34.758886Z","end":"2026-05-28T12:39:35.335292Z","steps":["trace[29415108] 'agreement among raft nodes before linearized reading' (duration: 576.341508ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:35.335319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:34.758869Z","time spent":"576.44595ms","remote":"127.0.0.1:48266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1889,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-05-28T12:39:35.335485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.839878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.221\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-28T12:39:35.335623Z","caller":"traceutil/trace.go:171","msg":"trace[1542830320] range","detail":"{range_begin:/registry/masterleases/199.19.213.221; range_end:; response_count:1; response_revision:4838; }","duration":"630.039024ms","start":"2026-05-28T12:39:34.70557Z","end":"2026-05-28T12:39:35.335609Z","steps":["trace[1542830320] 'agreement among raft nodes before linearized reading' (duration: 629.714646ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:35.336045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:34.705554Z","time spent":"630.474294ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.19.213.221\" "} {"level":"warn","ts":"2026-05-28T12:39:35.336598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.3622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16400"} {"level":"info","ts":"2026-05-28T12:39:35.336692Z","caller":"traceutil/trace.go:171","msg":"trace[1406551992] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4838; }","duration":"634.484673ms","start":"2026-05-28T12:39:34.702195Z","end":"2026-05-28T12:39:35.336679Z","steps":["trace[1406551992] 'agreement among raft nodes before linearized reading' (duration: 632.119815ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:35.336782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:39:34.702179Z","time spent":"634.590865ms","remote":"127.0.0.1:48294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":16424,"request content":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"info","ts":"2026-05-28T12:39:35.463278Z","caller":"traceutil/trace.go:171","msg":"trace[1892123334] linearizableReadLoop","detail":"{readStateIndex:5033; appliedIndex:5031; }","duration":"113.990274ms","start":"2026-05-28T12:39:35.349268Z","end":"2026-05-28T12:39:35.463258Z","steps":["trace[1892123334] 'read index received' (duration: 90.107784ms)","trace[1892123334] 'applied index is now lower than readState.Index' (duration: 23.881669ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:39:35.463292Z","caller":"traceutil/trace.go:171","msg":"trace[1542870741] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"120.940734ms","start":"2026-05-28T12:39:35.34231Z","end":"2026-05-28T12:39:35.463251Z","steps":["trace[1542870741] 'process raft request' (duration: 97.080915ms)","trace[1542870741] 'compare' (duration: 23.647394ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:39:35.46339Z","caller":"traceutil/trace.go:171","msg":"trace[906352589] transaction","detail":"{read_only:false; response_revision:4842; number_of_response:1; }","duration":"114.374472ms","start":"2026-05-28T12:39:35.349005Z","end":"2026-05-28T12:39:35.46338Z","steps":["trace[906352589] 'process raft request' (duration: 114.173967ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:35.46368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.139419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:10828"} {"level":"info","ts":"2026-05-28T12:39:35.463711Z","caller":"traceutil/trace.go:171","msg":"trace[908163957] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4842; }","duration":"121.183759ms","start":"2026-05-28T12:39:35.34252Z","end":"2026-05-28T12:39:35.463704Z","steps":["trace[908163957] 'agreement among raft nodes before linearized reading' (duration: 121.063707ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:35.464475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.492547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone-nodes\" ","response":"range_response_count:1 size:1265"} {"level":"info","ts":"2026-05-28T12:39:35.464552Z","caller":"traceutil/trace.go:171","msg":"trace[86582161] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone-nodes; range_end:; response_count:1; response_revision:4842; }","duration":"110.596969ms","start":"2026-05-28T12:39:35.353938Z","end":"2026-05-28T12:39:35.464534Z","steps":["trace[86582161] 'agreement among raft nodes before linearized reading' (duration: 110.166139ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:35.465105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.733716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-05-28T12:39:35.465172Z","caller":"traceutil/trace.go:171","msg":"trace[1414163608] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4842; }","duration":"113.821298ms","start":"2026-05-28T12:39:35.351335Z","end":"2026-05-28T12:39:35.465156Z","steps":["trace[1414163608] 'agreement among raft nodes before linearized reading' (duration: 112.721331ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:39:35.673921Z","caller":"traceutil/trace.go:171","msg":"trace[1227648434] transaction","detail":"{read_only:false; response_revision:4849; number_of_response:1; }","duration":"103.657228ms","start":"2026-05-28T12:39:35.570241Z","end":"2026-05-28T12:39:35.673898Z","steps":["trace[1227648434] 'process raft request' (duration: 103.495003ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:39:35.721041Z","caller":"traceutil/trace.go:171","msg":"trace[1929228632] linearizableReadLoop","detail":"{readStateIndex:5041; appliedIndex:5039; }","duration":"148.072204ms","start":"2026-05-28T12:39:35.572945Z","end":"2026-05-28T12:39:35.721017Z","steps":["trace[1929228632] 'read index received' (duration: 100.840079ms)","trace[1929228632] 'applied index is now lower than readState.Index' (duration: 47.231075ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:39:35.721186Z","caller":"traceutil/trace.go:171","msg":"trace[1890154346] transaction","detail":"{read_only:false; response_revision:4850; number_of_response:1; }","duration":"149.006927ms","start":"2026-05-28T12:39:35.572147Z","end":"2026-05-28T12:39:35.721154Z","steps":["trace[1890154346] 'process raft request' (duration: 148.699679ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:35.721419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.441554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-05-28T12:39:35.721508Z","caller":"traceutil/trace.go:171","msg":"trace[2034471826] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4850; }","duration":"148.584836ms","start":"2026-05-28T12:39:35.57291Z","end":"2026-05-28T12:39:35.721495Z","steps":["trace[2034471826] 'agreement among raft nodes before linearized reading' (duration: 148.315929ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:35.721413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.022468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T12:39:35.721693Z","caller":"traceutil/trace.go:171","msg":"trace[1819614692] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:4850; }","duration":"115.318676ms","start":"2026-05-28T12:39:35.606299Z","end":"2026-05-28T12:39:35.721617Z","steps":["trace[1819614692] 'agreement among raft nodes before linearized reading' (duration: 115.012088ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:36.02216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.474442ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T12:39:36.022476Z","caller":"traceutil/trace.go:171","msg":"trace[526211391] linearizableReadLoop","detail":"{readStateIndex:5043; appliedIndex:5041; }","duration":"288.929978ms","start":"2026-05-28T12:39:35.733525Z","end":"2026-05-28T12:39:36.022455Z","steps":["trace[526211391] 'read index received' (duration: 93.105118ms)","trace[526211391] 'applied index is now lower than readState.Index' (duration: 195.82073ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:39:36.022583Z","caller":"traceutil/trace.go:171","msg":"trace[2088412875] transaction","detail":"{read_only:false; response_revision:4852; number_of_response:1; }","duration":"289.318667ms","start":"2026-05-28T12:39:35.733255Z","end":"2026-05-28T12:39:36.022573Z","steps":["trace[2088412875] 'process raft request' (duration: 289.073701ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:39:36.022938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.406191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-05-28T12:39:36.022995Z","caller":"traceutil/trace.go:171","msg":"trace[1120037390] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:4852; }","duration":"289.472041ms","start":"2026-05-28T12:39:35.7335Z","end":"2026-05-28T12:39:36.022972Z","steps":["trace[1120037390] 'agreement among raft nodes before linearized reading' (duration: 289.288646ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:39:36.023481Z","caller":"traceutil/trace.go:171","msg":"trace[1874018737] transaction","detail":"{read_only:false; response_revision:4851; number_of_response:1; }","duration":"293.670304ms","start":"2026-05-28T12:39:35.729778Z","end":"2026-05-28T12:39:36.023449Z","steps":["trace[1874018737] 'process raft request' (duration: 96.798347ms)","trace[1874018737] 'compare' (duration: 195.230876ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T12:39:36.023496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.010914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-28T12:39:36.023503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.356304ms","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-05-28T12:39:36.023563Z","caller":"traceutil/trace.go:171","msg":"trace[911115638] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:4852; }","duration":"140.118226ms","start":"2026-05-28T12:39:35.883428Z","end":"2026-05-28T12:39:36.023547Z","steps":["trace[911115638] 'agreement among raft nodes before linearized reading' (duration: 139.995833ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:39:36.023615Z","caller":"traceutil/trace.go:171","msg":"trace[566343307] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4852; }","duration":"228.454086ms","start":"2026-05-28T12:39:35.795112Z","end":"2026-05-28T12:39:36.023566Z","steps":["trace[566343307] 'agreement among raft nodes before linearized reading' (duration: 228.187839ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:40:21.748745Z","caller":"traceutil/trace.go:171","msg":"trace[840407693] transaction","detail":"{read_only:false; response_revision:5246; number_of_response:1; }","duration":"123.402064ms","start":"2026-05-28T12:40:21.625318Z","end":"2026-05-28T12:40:21.74872Z","steps":["trace[840407693] 'process raft request' (duration: 70.146156ms)","trace[840407693] 'compare' (duration: 52.950871ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:41:11.511836Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2872} {"level":"info","ts":"2026-05-28T12:41:11.793256Z","caller":"traceutil/trace.go:171","msg":"trace[1902668530] transaction","detail":"{read_only:false; response_revision:5608; number_of_response:1; }","duration":"116.948518ms","start":"2026-05-28T12:41:11.676273Z","end":"2026-05-28T12:41:11.793222Z","steps":["trace[1902668530] 'process raft request' (duration: 49.436768ms)","trace[1902668530] 'compare' (duration: 34.984088ms)","trace[1902668530] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/openstack/messaging-topology-operator-leader-election; req_size:553; } (duration: 31.776445ms)"],"step_count":3} {"level":"warn","ts":"2026-05-28T12:41:12.095315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.213012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-28T12:41:12.095422Z","caller":"traceutil/trace.go:171","msg":"trace[1741952588] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5610; }","duration":"120.401716ms","start":"2026-05-28T12:41:11.974993Z","end":"2026-05-28T12:41:12.095395Z","steps":["trace[1741952588] 'range keys from in-memory index tree' (duration: 119.953006ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:41:12.168376Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2872,"took":"655.100865ms","hash":1740104917,"current-db-size-bytes":54140928,"current-db-size":"54 MB","current-db-size-in-use-bytes":29614080,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-28T12:41:12.168452Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1740104917,"revision":2872,"compact-revision":-1} {"level":"info","ts":"2026-05-28T12:43:06.408334Z","caller":"traceutil/trace.go:171","msg":"trace[460851176] transaction","detail":"{read_only:false; response_revision:6387; number_of_response:1; }","duration":"188.537536ms","start":"2026-05-28T12:43:06.219769Z","end":"2026-05-28T12:43:06.408306Z","steps":["trace[460851176] 'process raft request' (duration: 188.321581ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:43:06.445256Z","caller":"traceutil/trace.go:171","msg":"trace[1134506678] transaction","detail":"{read_only:false; response_revision:6389; number_of_response:1; }","duration":"169.560583ms","start":"2026-05-28T12:43:06.275674Z","end":"2026-05-28T12:43:06.445234Z","steps":["trace[1134506678] 'process raft request' (duration: 169.519132ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:43:06.446458Z","caller":"traceutil/trace.go:171","msg":"trace[1712150520] transaction","detail":"{read_only:false; response_revision:6388; number_of_response:1; }","duration":"172.026676ms","start":"2026-05-28T12:43:06.27438Z","end":"2026-05-28T12:43:06.446407Z","steps":["trace[1712150520] 'process raft request' (duration: 170.680257ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:43:12.527537Z","caller":"traceutil/trace.go:171","msg":"trace[997827821] transaction","detail":"{read_only:false; response_revision:6419; number_of_response:1; }","duration":"100.154943ms","start":"2026-05-28T12:43:12.427358Z","end":"2026-05-28T12:43:12.527513Z","steps":["trace[997827821] 'process raft request' (duration: 100.019ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:43:12.812801Z","caller":"traceutil/trace.go:171","msg":"trace[520397200] transaction","detail":"{read_only:false; response_revision:6422; number_of_response:1; }","duration":"122.01343ms","start":"2026-05-28T12:43:12.690766Z","end":"2026-05-28T12:43:12.812779Z","steps":["trace[520397200] 'process raft request' (duration: 121.667923ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:43:13.512158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.186395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"} {"level":"info","ts":"2026-05-28T12:43:13.512235Z","caller":"traceutil/trace.go:171","msg":"trace[1582791056] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6422; }","duration":"634.313868ms","start":"2026-05-28T12:43:12.877902Z","end":"2026-05-28T12:43:13.512216Z","steps":["trace[1582791056] 'range keys from in-memory index tree' (duration: 634.040482ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:43:13.512274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:43:12.877882Z","time spent":"634.384759ms","remote":"127.0.0.1:48326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4808,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"warn","ts":"2026-05-28T12:43:13.512461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.378333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"} {"level":"info","ts":"2026-05-28T12:43:13.512479Z","caller":"traceutil/trace.go:171","msg":"trace[413282604] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6422; }","duration":"597.447363ms","start":"2026-05-28T12:43:12.915026Z","end":"2026-05-28T12:43:13.512474Z","steps":["trace[413282604] 'range keys from in-memory index tree' (duration: 597.26149ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:43:13.512496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:43:12.915004Z","time spent":"597.487655ms","remote":"127.0.0.1:48326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4808,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"warn","ts":"2026-05-28T12:43:13.512497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.963514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T12:43:13.512564Z","caller":"traceutil/trace.go:171","msg":"trace[948461809] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6422; }","duration":"325.079876ms","start":"2026-05-28T12:43:13.187467Z","end":"2026-05-28T12:43:13.512547Z","steps":["trace[948461809] 'range keys from in-memory index tree' (duration: 324.881052ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:43:13.512604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:43:13.187447Z","time spent":"325.148878ms","remote":"127.0.0.1:54818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-28T12:43:13.691642Z","caller":"traceutil/trace.go:171","msg":"trace[1489401357] transaction","detail":"{read_only:false; response_revision:6423; number_of_response:1; }","duration":"367.501571ms","start":"2026-05-28T12:43:13.324116Z","end":"2026-05-28T12:43:13.691618Z","steps":["trace[1489401357] 'process raft request' (duration: 367.346957ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:43:13.691805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:43:13.324053Z","time spent":"367.662385ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T12:43:13.69182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.944039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-28T12:43:13.691851Z","caller":"traceutil/trace.go:171","msg":"trace[793198987] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6423; }","duration":"255.99835ms","start":"2026-05-28T12:43:13.435847Z","end":"2026-05-28T12:43:13.691845Z","steps":["trace[793198987] 'agreement among raft nodes before linearized reading' (duration: 255.881828ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:43:13.691681Z","caller":"traceutil/trace.go:171","msg":"trace[704643296] linearizableReadLoop","detail":"{readStateIndex:6665; appliedIndex:6665; }","duration":"255.781426ms","start":"2026-05-28T12:43:13.435861Z","end":"2026-05-28T12:43:13.691643Z","steps":["trace[704643296] 'read index received' (duration: 255.769305ms)","trace[704643296] 'applied index is now lower than readState.Index' (duration: 10.031µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:43:14.12909Z","caller":"traceutil/trace.go:171","msg":"trace[1529652303] linearizableReadLoop","detail":"{readStateIndex:6666; appliedIndex:6665; }","duration":"436.915304ms","start":"2026-05-28T12:43:13.692159Z","end":"2026-05-28T12:43:14.129074Z","steps":["trace[1529652303] 'read index received' (duration: 436.832732ms)","trace[1529652303] 'applied index is now lower than readState.Index' (duration: 81.812µs)"],"step_count":2} {"level":"warn","ts":"2026-05-28T12:43:14.12923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.253873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-28T12:43:14.129305Z","caller":"traceutil/trace.go:171","msg":"trace[266880651] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6424; }","duration":"510.364205ms","start":"2026-05-28T12:43:13.618926Z","end":"2026-05-28T12:43:14.129291Z","steps":["trace[266880651] 'agreement among raft nodes before linearized reading' (duration: 510.17102ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:43:14.129166Z","caller":"traceutil/trace.go:171","msg":"trace[1744365387] transaction","detail":"{read_only:false; response_revision:6424; number_of_response:1; }","duration":"676.489497ms","start":"2026-05-28T12:43:13.452667Z","end":"2026-05-28T12:43:14.129157Z","steps":["trace[1744365387] 'process raft request' (duration: 676.305823ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:43:14.129286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.57451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-28T12:43:14.129343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:43:13.618917Z","time spent":"510.418185ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-28T12:43:14.129337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.402153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T12:43:14.12936Z","caller":"traceutil/trace.go:171","msg":"trace[2107863046] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6424; }","duration":"588.680312ms","start":"2026-05-28T12:43:13.540663Z","end":"2026-05-28T12:43:14.129343Z","steps":["trace[2107863046] 'agreement among raft nodes before linearized reading' (duration: 588.541ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:43:14.129422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:43:13.540652Z","time spent":"588.761764ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-28T12:43:14.129422Z","caller":"traceutil/trace.go:171","msg":"trace[2136681502] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6424; }","duration":"614.662209ms","start":"2026-05-28T12:43:13.514739Z","end":"2026-05-28T12:43:14.129401Z","steps":["trace[2136681502] 'agreement among raft nodes before linearized reading' (duration: 614.494345ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:43:14.129378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:43:13.452639Z","time spent":"676.69734ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T12:43:14.129478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:43:13.514707Z","time spent":"614.762341ms","remote":"127.0.0.1:54828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-28T12:43:14.129227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.373448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-28T12:43:14.129574Z","caller":"traceutil/trace.go:171","msg":"trace[995646626] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6424; }","duration":"517.748066ms","start":"2026-05-28T12:43:13.611818Z","end":"2026-05-28T12:43:14.129566Z","steps":["trace[995646626] 'agreement among raft nodes before linearized reading' (duration: 517.364077ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:43:14.12962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:43:13.611811Z","time spent":"517.803817ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-28T12:43:14.304694Z","caller":"traceutil/trace.go:171","msg":"trace[730568758] linearizableReadLoop","detail":"{readStateIndex:6667; appliedIndex:6666; }","duration":"175.404712ms","start":"2026-05-28T12:43:14.129265Z","end":"2026-05-28T12:43:14.30467Z","steps":["trace[730568758] 'read index received' (duration: 126.035747ms)","trace[730568758] 'applied index is now lower than readState.Index' (duration: 49.367905ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:43:14.304807Z","caller":"traceutil/trace.go:171","msg":"trace[1751680865] transaction","detail":"{read_only:false; response_revision:6425; number_of_response:1; }","duration":"608.437292ms","start":"2026-05-28T12:43:13.696355Z","end":"2026-05-28T12:43:14.304792Z","steps":["trace[1751680865] 'process raft request' (duration: 558.993304ms)","trace[1751680865] 'compare' (duration: 49.122291ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T12:43:14.304938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:43:13.696331Z","time spent":"608.513794ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T12:43:14.304956Z","caller":"traceutil/trace.go:171","msg":"trace[1956839133] transaction","detail":"{read_only:false; response_revision:6426; number_of_response:1; }","duration":"171.238732ms","start":"2026-05-28T12:43:14.133691Z","end":"2026-05-28T12:43:14.30493Z","steps":["trace[1956839133] 'process raft request' (duration: 170.945335ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:43:14.305149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.869438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-28T12:43:14.305184Z","caller":"traceutil/trace.go:171","msg":"trace[1035865483] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:6426; }","duration":"578.96928ms","start":"2026-05-28T12:43:13.726203Z","end":"2026-05-28T12:43:14.305172Z","steps":["trace[1035865483] 'agreement among raft nodes before linearized reading' (duration: 578.567031ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:43:14.305216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:43:13.726185Z","time spent":"579.02099ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-05-28T12:43:14.305362Z","caller":"traceutil/trace.go:171","msg":"trace[1309918565] transaction","detail":"{read_only:false; response_revision:6427; number_of_response:1; }","duration":"171.355514ms","start":"2026-05-28T12:43:14.133991Z","end":"2026-05-28T12:43:14.305346Z","steps":["trace[1309918565] 'process raft request' (duration: 170.844323ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:43:14.30535Z","caller":"traceutil/trace.go:171","msg":"trace[1214137128] transaction","detail":"{read_only:false; response_revision:6428; number_of_response:1; }","duration":"170.63677ms","start":"2026-05-28T12:43:14.134695Z","end":"2026-05-28T12:43:14.305331Z","steps":["trace[1214137128] 'process raft request' (duration: 170.540938ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:43:14.68417Z","caller":"traceutil/trace.go:171","msg":"trace[1344508860] linearizableReadLoop","detail":"{readStateIndex:6671; appliedIndex:6670; }","duration":"150.07705ms","start":"2026-05-28T12:43:14.534066Z","end":"2026-05-28T12:43:14.684143Z","steps":["trace[1344508860] 'read index received' (duration: 70.764452ms)","trace[1344508860] 'applied index is now lower than readState.Index' (duration: 79.311608ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:43:14.684225Z","caller":"traceutil/trace.go:171","msg":"trace[1413412156] transaction","detail":"{read_only:false; response_revision:6429; number_of_response:1; }","duration":"151.163214ms","start":"2026-05-28T12:43:14.533009Z","end":"2026-05-28T12:43:14.684173Z","steps":["trace[1413412156] 'process raft request' (duration: 71.816845ms)","trace[1413412156] 'compare' (duration: 79.003141ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T12:43:14.684394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.307766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-05-28T12:43:14.68443Z","caller":"traceutil/trace.go:171","msg":"trace[1424764661] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6429; }","duration":"150.412699ms","start":"2026-05-28T12:43:14.534004Z","end":"2026-05-28T12:43:14.684417Z","steps":["trace[1424764661] 'agreement among raft nodes before linearized reading' (duration: 150.247655ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:43:14.735332Z","caller":"traceutil/trace.go:171","msg":"trace[908249407] transaction","detail":"{read_only:false; response_revision:6430; number_of_response:1; }","duration":"189.258404ms","start":"2026-05-28T12:43:14.546049Z","end":"2026-05-28T12:43:14.735307Z","steps":["trace[908249407] 'process raft request' (duration: 189.110011ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:43:14.735705Z","caller":"traceutil/trace.go:171","msg":"trace[468049303] transaction","detail":"{read_only:false; response_revision:6431; number_of_response:1; }","duration":"189.394468ms","start":"2026-05-28T12:43:14.546291Z","end":"2026-05-28T12:43:14.735686Z","steps":["trace[468049303] 'process raft request' (duration: 188.976629ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:43:14.902368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.223642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T12:43:14.902476Z","caller":"traceutil/trace.go:171","msg":"trace[1547069687] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:6432; }","duration":"110.406386ms","start":"2026-05-28T12:43:14.792044Z","end":"2026-05-28T12:43:14.90245Z","steps":["trace[1547069687] 'range keys from in-memory index tree' (duration: 110.10885ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:44:12.639285Z","caller":"traceutil/trace.go:171","msg":"trace[999840508] transaction","detail":"{read_only:false; response_revision:6787; number_of_response:1; }","duration":"103.928581ms","start":"2026-05-28T12:44:12.535331Z","end":"2026-05-28T12:44:12.639259Z","steps":["trace[999840508] 'process raft request' (duration: 103.741767ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:44:15.766252Z","caller":"traceutil/trace.go:171","msg":"trace[2119657178] transaction","detail":"{read_only:false; response_revision:6809; number_of_response:1; }","duration":"189.250089ms","start":"2026-05-28T12:44:15.57698Z","end":"2026-05-28T12:44:15.76623Z","steps":["trace[2119657178] 'process raft request' (duration: 187.849729ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:44:15.766715Z","caller":"traceutil/trace.go:171","msg":"trace[402384324] transaction","detail":"{read_only:false; response_revision:6811; number_of_response:1; }","duration":"186.827707ms","start":"2026-05-28T12:44:15.579865Z","end":"2026-05-28T12:44:15.766693Z","steps":["trace[402384324] 'process raft request' (duration: 186.49927ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:44:15.767061Z","caller":"traceutil/trace.go:171","msg":"trace[933360325] transaction","detail":"{read_only:false; response_revision:6810; number_of_response:1; }","duration":"189.77575ms","start":"2026-05-28T12:44:15.577272Z","end":"2026-05-28T12:44:15.767048Z","steps":["trace[933360325] 'process raft request' (duration: 188.902161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:45:31.592716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.129572ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T12:45:31.59291Z","caller":"traceutil/trace.go:171","msg":"trace[1863584996] transaction","detail":"{read_only:false; response_revision:7206; number_of_response:1; }","duration":"254.536761ms","start":"2026-05-28T12:45:31.338357Z","end":"2026-05-28T12:45:31.592893Z","steps":["trace[1863584996] 'process raft request' (duration: 254.484569ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:45:31.593298Z","caller":"traceutil/trace.go:171","msg":"trace[1678928246] transaction","detail":"{read_only:false; response_revision:7205; number_of_response:1; }","duration":"258.755263ms","start":"2026-05-28T12:45:31.334511Z","end":"2026-05-28T12:45:31.593266Z","steps":["trace[1678928246] 'process raft request' (duration: 58.979421ms)","trace[1678928246] 'compare' (duration: 199.021878ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:45:32.028323Z","caller":"traceutil/trace.go:171","msg":"trace[695467220] transaction","detail":"{read_only:false; response_revision:7209; number_of_response:1; }","duration":"240.0762ms","start":"2026-05-28T12:45:31.788218Z","end":"2026-05-28T12:45:32.028294Z","steps":["trace[695467220] 'process raft request' (duration: 204.894063ms)","trace[695467220] 'compare' (duration: 35.084724ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:46:11.519737Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5607} {"level":"info","ts":"2026-05-28T12:46:11.633192Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5607,"took":"111.933111ms","hash":1098007706,"current-db-size-bytes":54140928,"current-db-size":"54 MB","current-db-size-in-use-bytes":18247680,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-28T12:46:11.633245Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1098007706,"revision":5607,"compact-revision":2872} {"level":"info","ts":"2026-05-28T12:46:24.887688Z","caller":"traceutil/trace.go:171","msg":"trace[130041314] transaction","detail":"{read_only:false; response_revision:7475; number_of_response:1; }","duration":"126.309525ms","start":"2026-05-28T12:46:24.761349Z","end":"2026-05-28T12:46:24.887658Z","steps":["trace[130041314] 'process raft request' (duration: 73.439682ms)","trace[130041314] 'compare' (duration: 52.728008ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T12:46:25.703595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.077755ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T12:46:25.703817Z","caller":"traceutil/trace.go:171","msg":"trace[1195489216] linearizableReadLoop","detail":"{readStateIndex:7766; appliedIndex:7764; }","duration":"237.374362ms","start":"2026-05-28T12:46:25.466426Z","end":"2026-05-28T12:46:25.7038Z","steps":["trace[1195489216] 'read index received' (duration: 135.005288ms)","trace[1195489216] 'applied index is now lower than readState.Index' (duration: 102.367944ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:46:25.703912Z","caller":"traceutil/trace.go:171","msg":"trace[382394038] transaction","detail":"{read_only:false; response_revision:7479; number_of_response:1; }","duration":"271.292645ms","start":"2026-05-28T12:46:25.432609Z","end":"2026-05-28T12:46:25.703901Z","steps":["trace[382394038] 'process raft request' (duration: 168.825137ms)","trace[382394038] 'compare' (duration: 101.8892ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:46:25.704182Z","caller":"traceutil/trace.go:171","msg":"trace[610347176] transaction","detail":"{read_only:false; response_revision:7480; number_of_response:1; }","duration":"262.137714ms","start":"2026-05-28T12:46:25.442034Z","end":"2026-05-28T12:46:25.704172Z","steps":["trace[610347176] 'process raft request' (duration: 261.680631ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:46:25.704342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.309183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-28T12:46:25.704609Z","caller":"traceutil/trace.go:171","msg":"trace[221479863] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7480; }","duration":"211.632153ms","start":"2026-05-28T12:46:25.492961Z","end":"2026-05-28T12:46:25.704593Z","steps":["trace[221479863] 'agreement among raft nodes before linearized reading' (duration: 211.19897ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:46:25.704405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.965159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/auth-system/\" range_end:\"/registry/secrets/auth-system0\" ","response":"range_response_count:4 size:81057"} {"level":"info","ts":"2026-05-28T12:46:25.704914Z","caller":"traceutil/trace.go:171","msg":"trace[1744806473] range","detail":"{range_begin:/registry/secrets/auth-system/; range_end:/registry/secrets/auth-system0; response_count:4; response_revision:7480; }","duration":"238.529657ms","start":"2026-05-28T12:46:25.466371Z","end":"2026-05-28T12:46:25.704901Z","steps":["trace[1744806473] 'agreement among raft nodes before linearized reading' (duration: 237.824776ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:46:58.383478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.073542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/kube-system/kube-prometheus-stack-coredns\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-05-28T12:46:58.38357Z","caller":"traceutil/trace.go:171","msg":"trace[1059164797] range","detail":"{range_begin:/registry/services/endpoints/kube-system/kube-prometheus-stack-coredns; range_end:; response_count:1; response_revision:7641; }","duration":"475.214147ms","start":"2026-05-28T12:46:57.908335Z","end":"2026-05-28T12:46:58.38355Z","steps":["trace[1059164797] 'range keys from in-memory index tree' (duration: 474.894827ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:46:58.383622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:46:57.908314Z","time spent":"475.29851ms","remote":"127.0.0.1:48280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":1393,"request content":"key:\"/registry/services/endpoints/kube-system/kube-prometheus-stack-coredns\" "} {"level":"warn","ts":"2026-05-28T12:46:58.383732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.63269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-28T12:46:58.383855Z","caller":"traceutil/trace.go:171","msg":"trace[1757981913] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7641; }","duration":"443.794044ms","start":"2026-05-28T12:46:57.940037Z","end":"2026-05-28T12:46:58.383831Z","steps":["trace[1757981913] 'range keys from in-memory index tree' (duration: 443.328362ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:46:58.383911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:46:57.940025Z","time spent":"443.870697ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-28T12:46:58.384816Z","caller":"traceutil/trace.go:171","msg":"trace[1859579536] transaction","detail":"{read_only:false; response_revision:7642; number_of_response:1; }","duration":"438.450651ms","start":"2026-05-28T12:46:57.946331Z","end":"2026-05-28T12:46:58.384782Z","steps":["trace[1859579536] 'process raft request' (duration: 438.287327ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:46:58.385006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:46:57.946313Z","time spent":"438.598336ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T12:46:58.386765Z","caller":"traceutil/trace.go:171","msg":"trace[512927314] linearizableReadLoop","detail":"{readStateIndex:7935; appliedIndex:7934; }","duration":"438.002749ms","start":"2026-05-28T12:46:57.94874Z","end":"2026-05-28T12:46:58.386743Z","steps":["trace[512927314] 'read index received' (duration: 436.197187ms)","trace[512927314] 'applied index is now lower than readState.Index' (duration: 1.804642ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T12:46:58.387078Z","caller":"traceutil/trace.go:171","msg":"trace[1297992416] transaction","detail":"{read_only:false; response_revision:7643; number_of_response:1; }","duration":"440.618734ms","start":"2026-05-28T12:46:57.946447Z","end":"2026-05-28T12:46:58.387065Z","steps":["trace[1297992416] 'process raft request' (duration: 440.16089ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:46:58.387178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:46:57.946422Z","time spent":"440.683616ms","remote":"127.0.0.1:48350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T12:46:58.387422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.676208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/kube-system/kube-dns\" ","response":"range_response_count:1 size:757"} {"level":"info","ts":"2026-05-28T12:46:58.387463Z","caller":"traceutil/trace.go:171","msg":"trace[2102736074] range","detail":"{range_begin:/registry/services/endpoints/kube-system/kube-dns; range_end:; response_count:1; response_revision:7643; }","duration":"438.73082ms","start":"2026-05-28T12:46:57.948721Z","end":"2026-05-28T12:46:58.387451Z","steps":["trace[2102736074] 'agreement among raft nodes before linearized reading' (duration: 438.608036ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T12:46:58.387491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T12:46:57.948713Z","time spent":"438.772051ms","remote":"127.0.0.1:48280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":781,"request content":"key:\"/registry/services/endpoints/kube-system/kube-dns\" "} {"level":"warn","ts":"2026-05-28T12:46:58.387824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.277402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-28T12:46:58.387926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.918624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T12:46:58.387946Z","caller":"traceutil/trace.go:171","msg":"trace[562568854] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7643; }","duration":"134.449878ms","start":"2026-05-28T12:46:58.253483Z","end":"2026-05-28T12:46:58.387933Z","steps":["trace[562568854] 'agreement among raft nodes before linearized reading' (duration: 133.84003ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T12:46:58.387977Z","caller":"traceutil/trace.go:171","msg":"trace[854707725] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7643; }","duration":"202.009777ms","start":"2026-05-28T12:46:58.185953Z","end":"2026-05-28T12:46:58.387963Z","steps":["trace[854707725] 'agreement among raft nodes before linearized reading' (duration: 201.259015ms)"],"step_count":1}