{"level":"warn","ts":"2026-05-28T13:51:02.434788Z","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-28T13:51:02.434933Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.53:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.53:2380","--initial-cluster=instance=https://199.204.45.53:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.53:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.53: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-28T13:51:02.435095Z","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-28T13:51:02.435164Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-05-28T13:51:02.435271Z","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-28T13:51:02.436229Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"]} {"level":"info","ts":"2026-05-28T13:51:02.436413Z","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":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.53: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-28T13:51:02.438956Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.150921ms"} {"level":"info","ts":"2026-05-28T13:51:02.448988Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c47ca1a7b1fe506b","cluster-id":"95bd21e158fabf07"} {"level":"info","ts":"2026-05-28T13:51:02.449152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=()"} {"level":"info","ts":"2026-05-28T13:51:02.4492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 0"} {"level":"info","ts":"2026-05-28T13:51:02.44923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c47ca1a7b1fe506b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-28T13:51:02.449265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 1"} {"level":"info","ts":"2026-05-28T13:51:02.449343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"warn","ts":"2026-05-28T13:51:02.453536Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-28T13:51:02.45537Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-28T13:51:02.458104Z","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-28T13:51:02.46129Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c47ca1a7b1fe506b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-28T13:51:02.461527Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c47ca1a7b1fe506b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-28T13:51:02.461639Z","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-28T13:51:02.461706Z","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-28T13:51:02.461717Z","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-28T13:51:02.462799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"info","ts":"2026-05-28T13:51:02.46398Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"c47ca1a7b1fe506b","added-peer-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-05-28T13:51:02.467434Z","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-28T13:51:02.467663Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-05-28T13:51:02.467732Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-05-28T13:51:02.46796Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c47ca1a7b1fe506b","initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-28T13:51:02.468038Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-28T13:51:02.649568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b is starting a new election at term 1"} {"level":"info","ts":"2026-05-28T13:51:02.649646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became pre-candidate at term 1"} {"level":"info","ts":"2026-05-28T13:51:02.649703Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgPreVoteResp from c47ca1a7b1fe506b at term 1"} {"level":"info","ts":"2026-05-28T13:51:02.649728Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became candidate at term 2"} {"level":"info","ts":"2026-05-28T13:51:02.649741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgVoteResp from c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-05-28T13:51:02.649759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became leader at term 2"} {"level":"info","ts":"2026-05-28T13:51:02.649774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c47ca1a7b1fe506b elected leader c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-05-28T13:51:02.65085Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T13:51:02.651638Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c47ca1a7b1fe506b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.53:2379]}","request-path":"/0/members/c47ca1a7b1fe506b/attributes","cluster-id":"95bd21e158fabf07","publish-timeout":"7s"} {"level":"info","ts":"2026-05-28T13:51:02.651669Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-28T13:51:02.651709Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-28T13:51:02.652031Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T13:51:02.652076Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-28T13:51:02.652129Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-28T13:51:02.652161Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T13:51:02.652209Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T13:51:02.654488Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-28T13:51:02.655556Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.53:2379"} {"level":"info","ts":"2026-05-28T13:51:26.523401Z","caller":"traceutil/trace.go:171","msg":"trace[1671106467] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"258.037345ms","start":"2026-05-28T13:51:26.2653Z","end":"2026-05-28T13:51:26.523338Z","steps":["trace[1671106467] 'process raft request' (duration: 257.842249ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:51:46.575711Z","caller":"traceutil/trace.go:171","msg":"trace[2061239223] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"107.208314ms","start":"2026-05-28T13:51:46.468469Z","end":"2026-05-28T13:51:46.575678Z","steps":["trace[2061239223] 'process raft request' (duration: 106.72123ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:51:46.869986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.758845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-28T13:51:46.870163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.443469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-28T13:51:46.870221Z","caller":"traceutil/trace.go:171","msg":"trace[733345340] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:582; }","duration":"120.532182ms","start":"2026-05-28T13:51:46.749664Z","end":"2026-05-28T13:51:46.870196Z","steps":["trace[733345340] 'range keys from in-memory index tree' (duration: 120.308196ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:51:46.870157Z","caller":"traceutil/trace.go:171","msg":"trace[191497537] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:582; }","duration":"232.005772ms","start":"2026-05-28T13:51:46.638124Z","end":"2026-05-28T13:51:46.87013Z","steps":["trace[191497537] 'range keys from in-memory index tree' (duration: 231.526909ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:51:46.87005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.745944ms","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-28T13:51:46.870517Z","caller":"traceutil/trace.go:171","msg":"trace[1713705352] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:582; }","duration":"118.247538ms","start":"2026-05-28T13:51:46.752214Z","end":"2026-05-28T13:51:46.870461Z","steps":["trace[1713705352] 'range keys from in-memory index tree' (duration: 117.510568ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:51:47.057539Z","caller":"traceutil/trace.go:171","msg":"trace[1642230534] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"183.547763ms","start":"2026-05-28T13:51:46.87396Z","end":"2026-05-28T13:51:47.057507Z","steps":["trace[1642230534] 'process raft request' (duration: 183.345968ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:51:47.331813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.30571ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T13:51:47.332133Z","caller":"traceutil/trace.go:171","msg":"trace[985367057] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"456.743485ms","start":"2026-05-28T13:51:46.875341Z","end":"2026-05-28T13:51:47.332084Z","steps":["trace[985367057] 'process raft request' (duration: 337.306943ms)","trace[985367057] 'compare' (duration: 118.135996ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T13:51:47.332355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.002144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9rxvh\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-28T13:51:47.332412Z","caller":"traceutil/trace.go:171","msg":"trace[596429613] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9rxvh; range_end:; response_count:1; response_revision:584; }","duration":"435.113197ms","start":"2026-05-28T13:51:46.897279Z","end":"2026-05-28T13:51:47.332392Z","steps":["trace[596429613] 'agreement among raft nodes before linearized reading' (duration: 434.947413ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:51:47.332462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T13:51:46.897251Z","time spent":"435.203379ms","remote":"127.0.0.1:49800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-9rxvh\" "} {"level":"warn","ts":"2026-05-28T13:51:47.332469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T13:51:46.875312Z","time spent":"456.952241ms","remote":"127.0.0.1:49892","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-28T13:51:47.332158Z","caller":"traceutil/trace.go:171","msg":"trace[1526469086] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:607; }","duration":"434.772147ms","start":"2026-05-28T13:51:46.897354Z","end":"2026-05-28T13:51:47.332126Z","steps":["trace[1526469086] 'read index received' (duration: 160.555057ms)","trace[1526469086] 'applied index is now lower than readState.Index' (duration: 274.21383ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T13:51:47.339851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.717211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-28T13:51:47.339895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.226953ms","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-28T13:51:47.339983Z","caller":"traceutil/trace.go:171","msg":"trace[1139352891] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"245.874275ms","start":"2026-05-28T13:51:47.09406Z","end":"2026-05-28T13:51:47.339934Z","steps":["trace[1139352891] 'agreement among raft nodes before linearized reading' (duration: 245.509415ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:51:47.340011Z","caller":"traceutil/trace.go:171","msg":"trace[1734548815] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:585; }","duration":"281.391007ms","start":"2026-05-28T13:51:47.058582Z","end":"2026-05-28T13:51:47.339973Z","steps":["trace[1734548815] 'agreement among raft nodes before linearized reading' (duration: 280.917584ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:53:19.579584Z","caller":"traceutil/trace.go:171","msg":"trace[362713867] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"166.455022ms","start":"2026-05-28T13:53:19.413078Z","end":"2026-05-28T13:53:19.579533Z","steps":["trace[362713867] 'process raft request' (duration: 79.030599ms)","trace[362713867] 'compare' (duration: 87.185296ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T13:53:19.84524Z","caller":"traceutil/trace.go:171","msg":"trace[1250031116] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"129.032301ms","start":"2026-05-28T13:53:19.716172Z","end":"2026-05-28T13:53:19.845205Z","steps":["trace[1250031116] 'process raft request' (duration: 128.970779ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:53:19.845327Z","caller":"traceutil/trace.go:171","msg":"trace[1312724953] linearizableReadLoop","detail":"{readStateIndex:1903; appliedIndex:1902; }","duration":"286.200505ms","start":"2026-05-28T13:53:19.559068Z","end":"2026-05-28T13:53:19.845269Z","steps":["trace[1312724953] 'read index received' (duration: 203.863993ms)","trace[1312724953] 'applied index is now lower than readState.Index' (duration: 82.329522ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T13:53:19.845689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.590226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-28T13:53:19.845814Z","caller":"traceutil/trace.go:171","msg":"trace[1503120014] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1834; }","duration":"286.786291ms","start":"2026-05-28T13:53:19.559002Z","end":"2026-05-28T13:53:19.845788Z","steps":["trace[1503120014] 'agreement among raft nodes before linearized reading' (duration: 286.339909ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:53:19.845725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.949502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10667"} {"level":"info","ts":"2026-05-28T13:53:19.845952Z","caller":"traceutil/trace.go:171","msg":"trace[1881249616] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1834; }","duration":"261.24192ms","start":"2026-05-28T13:53:19.584694Z","end":"2026-05-28T13:53:19.845935Z","steps":["trace[1881249616] 'agreement among raft nodes before linearized reading' (duration: 260.791938ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:53:19.845848Z","caller":"traceutil/trace.go:171","msg":"trace[1533125499] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"338.319096ms","start":"2026-05-28T13:53:19.507471Z","end":"2026-05-28T13:53:19.84579Z","steps":["trace[1533125499] 'process raft request' (duration: 255.377928ms)","trace[1533125499] 'compare' (duration: 82.097955ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T13:53:19.846204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T13:53:19.507448Z","time spent":"338.652905ms","remote":"127.0.0.1:49892","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-28T13:53:20.209621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.265562ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T13:53:20.209763Z","caller":"traceutil/trace.go:171","msg":"trace[1988066208] linearizableReadLoop","detail":"{readStateIndex:1913; appliedIndex:1907; }","duration":"283.16381ms","start":"2026-05-28T13:53:19.926579Z","end":"2026-05-28T13:53:20.209743Z","steps":["trace[1988066208] 'read index received' (duration: 13.624699ms)","trace[1988066208] 'applied index is now lower than readState.Index' (duration: 269.537311ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T13:53:20.209804Z","caller":"traceutil/trace.go:171","msg":"trace[2078785413] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"293.429007ms","start":"2026-05-28T13:53:19.916325Z","end":"2026-05-28T13:53:20.209754Z","steps":["trace[2078785413] 'process raft request' (duration: 184.879866ms)","trace[2078785413] 'compare' (duration: 107.756628ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T13:53:20.210651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.058006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-28T13:53:20.210758Z","caller":"traceutil/trace.go:171","msg":"trace[1001235774] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1843; }","duration":"284.20434ms","start":"2026-05-28T13:53:19.926529Z","end":"2026-05-28T13:53:20.210733Z","steps":["trace[1001235774] 'agreement among raft nodes before linearized reading' (duration: 283.283614ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:53:32.209006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.641129ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T13:53:32.209484Z","caller":"traceutil/trace.go:171","msg":"trace[156484071] transaction","detail":"{read_only:false; response_revision:1939; number_of_response:1; }","duration":"321.477437ms","start":"2026-05-28T13:53:31.88797Z","end":"2026-05-28T13:53:32.209447Z","steps":["trace[156484071] 'process raft request' (duration: 53.256522ms)","trace[156484071] 'compare' (duration: 267.358751ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T13:53:32.209687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T13:53:31.88794Z","time spent":"321.631902ms","remote":"127.0.0.1:49892","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-28T13:53:32.209778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.444215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-28T13:53:32.209857Z","caller":"traceutil/trace.go:171","msg":"trace[1678921460] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1939; }","duration":"289.59909ms","start":"2026-05-28T13:53:31.92024Z","end":"2026-05-28T13:53:32.209839Z","steps":["trace[1678921460] 'agreement among raft nodes before linearized reading' (duration: 289.323932ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:53:32.209492Z","caller":"traceutil/trace.go:171","msg":"trace[1232748353] linearizableReadLoop","detail":"{readStateIndex:2012; appliedIndex:2011; }","duration":"289.093616ms","start":"2026-05-28T13:53:31.920312Z","end":"2026-05-28T13:53:32.209406Z","steps":["trace[1232748353] 'read index received' (duration: 20.806599ms)","trace[1232748353] 'applied index is now lower than readState.Index' (duration: 268.284657ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T13:53:32.21034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.899601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-28T13:53:32.210455Z","caller":"traceutil/trace.go:171","msg":"trace[1297315094] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:1939; }","duration":"275.049565ms","start":"2026-05-28T13:53:31.935378Z","end":"2026-05-28T13:53:32.210428Z","steps":["trace[1297315094] 'agreement among raft nodes before linearized reading' (duration: 274.86562ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:53:32.210465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.546805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T13:53:32.210533Z","caller":"traceutil/trace.go:171","msg":"trace[1277611469] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1939; }","duration":"115.631118ms","start":"2026-05-28T13:53:32.094886Z","end":"2026-05-28T13:53:32.210517Z","steps":["trace[1277611469] 'agreement among raft nodes before linearized reading' (duration: 115.550886ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:53:32.210585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.08984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-28T13:53:32.210384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.231806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T13:53:32.210653Z","caller":"traceutil/trace.go:171","msg":"trace[2082068539] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1939; }","duration":"204.196023ms","start":"2026-05-28T13:53:32.006441Z","end":"2026-05-28T13:53:32.210637Z","steps":["trace[2082068539] 'agreement among raft nodes before linearized reading' (duration: 204.032919ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:53:32.210684Z","caller":"traceutil/trace.go:171","msg":"trace[901491429] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1939; }","duration":"157.560405ms","start":"2026-05-28T13:53:32.053095Z","end":"2026-05-28T13:53:32.210656Z","steps":["trace[901491429] 'agreement among raft nodes before linearized reading' (duration: 157.209275ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:53:32.210722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.225019ms","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-28T13:53:32.210804Z","caller":"traceutil/trace.go:171","msg":"trace[1821232422] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1939; }","duration":"257.343312ms","start":"2026-05-28T13:53:31.953442Z","end":"2026-05-28T13:53:32.210785Z","steps":["trace[1821232422] 'agreement among raft nodes before linearized reading' (duration: 257.155927ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:54:04.438839Z","caller":"traceutil/trace.go:171","msg":"trace[885333159] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"109.825991ms","start":"2026-05-28T13:54:04.328985Z","end":"2026-05-28T13:54:04.438811Z","steps":["trace[885333159] 'process raft request' (duration: 109.516713ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:54:04.607047Z","caller":"traceutil/trace.go:171","msg":"trace[627491329] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"162.392943ms","start":"2026-05-28T13:54:04.444623Z","end":"2026-05-28T13:54:04.607016Z","steps":["trace[627491329] 'process raft request' (duration: 98.914032ms)","trace[627491329] 'compare' (duration: 63.294406ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T13:54:04.607234Z","caller":"traceutil/trace.go:171","msg":"trace[1773652244] linearizableReadLoop","detail":"{readStateIndex:2210; appliedIndex:2208; }","duration":"151.291289ms","start":"2026-05-28T13:54:04.455914Z","end":"2026-05-28T13:54:04.607205Z","steps":["trace[1773652244] 'read index received' (duration: 87.630553ms)","trace[1773652244] 'applied index is now lower than readState.Index' (duration: 63.658616ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T13:54:04.607385Z","caller":"traceutil/trace.go:171","msg":"trace[1271325944] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"161.562221ms","start":"2026-05-28T13:54:04.445808Z","end":"2026-05-28T13:54:04.607371Z","steps":["trace[1271325944] 'process raft request' (duration: 161.16798ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:54:04.607698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.750992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-28T13:54:04.60778Z","caller":"traceutil/trace.go:171","msg":"trace[1374765848] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2131; }","duration":"151.880765ms","start":"2026-05-28T13:54:04.45588Z","end":"2026-05-28T13:54:04.60776Z","steps":["trace[1374765848] 'agreement among raft nodes before linearized reading' (duration: 151.615908ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:54:10.599138Z","caller":"traceutil/trace.go:171","msg":"trace[596289267] linearizableReadLoop","detail":"{readStateIndex:2241; appliedIndex:2240; }","duration":"121.622485ms","start":"2026-05-28T13:54:10.477488Z","end":"2026-05-28T13:54:10.599111Z","steps":["trace[596289267] 'read index received' (duration: 121.348838ms)","trace[596289267] 'applied index is now lower than readState.Index' (duration: 271.627µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T13:54:10.599269Z","caller":"traceutil/trace.go:171","msg":"trace[1294113312] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"140.211225ms","start":"2026-05-28T13:54:10.459009Z","end":"2026-05-28T13:54:10.599221Z","steps":["trace[1294113312] 'process raft request' (duration: 139.841775ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:54:10.599496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.971664ms","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-28T13:54:10.599614Z","caller":"traceutil/trace.go:171","msg":"trace[2040341665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2161; }","duration":"122.16811ms","start":"2026-05-28T13:54:10.477421Z","end":"2026-05-28T13:54:10.599589Z","steps":["trace[2040341665] 'agreement among raft nodes before linearized reading' (duration: 121.819461ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:54:10.801398Z","caller":"traceutil/trace.go:171","msg":"trace[3328943] linearizableReadLoop","detail":"{readStateIndex:2242; appliedIndex:2241; }","duration":"170.487755ms","start":"2026-05-28T13:54:10.630875Z","end":"2026-05-28T13:54:10.801362Z","steps":["trace[3328943] 'read index received' (duration: 98.170042ms)","trace[3328943] 'applied index is now lower than readState.Index' (duration: 72.316543ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T13:54:10.80142Z","caller":"traceutil/trace.go:171","msg":"trace[1636558831] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"196.401486ms","start":"2026-05-28T13:54:10.604965Z","end":"2026-05-28T13:54:10.801367Z","steps":["trace[1636558831] 'process raft request' (duration: 124.074092ms)","trace[1636558831] 'compare' (duration: 72.095007ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T13:54:10.801619Z","caller":"traceutil/trace.go:171","msg":"trace[782666339] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"154.712973ms","start":"2026-05-28T13:54:10.646874Z","end":"2026-05-28T13:54:10.801587Z","steps":["trace[782666339] 'process raft request' (duration: 154.444055ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:54:10.801783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.887546ms","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-28T13:54:10.801835Z","caller":"traceutil/trace.go:171","msg":"trace[1610416018] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2163; }","duration":"170.964258ms","start":"2026-05-28T13:54:10.630856Z","end":"2026-05-28T13:54:10.80182Z","steps":["trace[1610416018] 'agreement among raft nodes before linearized reading' (duration: 170.697571ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:54:10.801882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.242406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-28T13:54:10.80199Z","caller":"traceutil/trace.go:171","msg":"trace[1585606902] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2163; }","duration":"144.375019ms","start":"2026-05-28T13:54:10.657593Z","end":"2026-05-28T13:54:10.801968Z","steps":["trace[1585606902] 'agreement among raft nodes before linearized reading' (duration: 144.117352ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:54:10.802059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.273535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-28T13:54:10.802191Z","caller":"traceutil/trace.go:171","msg":"trace[1688500671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2163; }","duration":"168.556192ms","start":"2026-05-28T13:54:10.633609Z","end":"2026-05-28T13:54:10.802165Z","steps":["trace[1688500671] 'agreement among raft nodes before linearized reading' (duration: 168.026078ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:54:10.801988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.851427ms","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-28T13:54:10.802352Z","caller":"traceutil/trace.go:171","msg":"trace[1425742288] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2163; }","duration":"147.272799ms","start":"2026-05-28T13:54:10.655051Z","end":"2026-05-28T13:54:10.802324Z","steps":["trace[1425742288] 'agreement among raft nodes before linearized reading' (duration: 146.714553ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:54:11.011746Z","caller":"traceutil/trace.go:171","msg":"trace[1242225772] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"204.92798ms","start":"2026-05-28T13:54:10.806787Z","end":"2026-05-28T13:54:11.011715Z","steps":["trace[1242225772] 'process raft request' (duration: 204.733154ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:54:11.01323Z","caller":"traceutil/trace.go:171","msg":"trace[1971563953] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"205.444684ms","start":"2026-05-28T13:54:10.807761Z","end":"2026-05-28T13:54:11.013206Z","steps":["trace[1971563953] 'process raft request' (duration: 205.358581ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:54:11.013232Z","caller":"traceutil/trace.go:171","msg":"trace[906402493] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"205.850164ms","start":"2026-05-28T13:54:10.80735Z","end":"2026-05-28T13:54:11.0132Z","steps":["trace[906402493] 'process raft request' (duration: 205.642409ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:55:33.375998Z","caller":"traceutil/trace.go:171","msg":"trace[1535306761] transaction","detail":"{read_only:false; response_revision:2802; number_of_response:1; }","duration":"104.202739ms","start":"2026-05-28T13:55:33.27177Z","end":"2026-05-28T13:55:33.375973Z","steps":["trace[1535306761] 'process raft request' (duration: 104.027314ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:58:14.252245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.329617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T13:58:14.252441Z","caller":"traceutil/trace.go:171","msg":"trace[1420822316] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:3850; }","duration":"113.574704ms","start":"2026-05-28T13:58:14.138844Z","end":"2026-05-28T13:58:14.252418Z","steps":["trace[1420822316] 'count revisions from in-memory index tree' (duration: 113.269246ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:59:32.619928Z","caller":"traceutil/trace.go:171","msg":"trace[2035183568] transaction","detail":"{read_only:false; response_revision:4753; number_of_response:1; }","duration":"131.103528ms","start":"2026-05-28T13:59:32.488795Z","end":"2026-05-28T13:59:32.619898Z","steps":["trace[2035183568] 'process raft request' (duration: 129.284278ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:59:32.624207Z","caller":"traceutil/trace.go:171","msg":"trace[953165351] linearizableReadLoop","detail":"{readStateIndex:4936; appliedIndex:4934; }","duration":"130.856892ms","start":"2026-05-28T13:59:32.493318Z","end":"2026-05-28T13:59:32.624175Z","steps":["trace[953165351] 'read index received' (duration: 124.792734ms)","trace[953165351] 'applied index is now lower than readState.Index' (duration: 6.063048ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T13:59:32.624354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.020566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T13:59:32.624395Z","caller":"traceutil/trace.go:171","msg":"trace[1224966190] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:0; response_revision:4754; }","duration":"131.109628ms","start":"2026-05-28T13:59:32.493271Z","end":"2026-05-28T13:59:32.624381Z","steps":["trace[1224966190] 'agreement among raft nodes before linearized reading' (duration: 131.025036ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:59:32.624619Z","caller":"traceutil/trace.go:171","msg":"trace[1718469228] transaction","detail":"{read_only:false; response_revision:4754; number_of_response:1; }","duration":"134.964105ms","start":"2026-05-28T13:59:32.489618Z","end":"2026-05-28T13:59:32.624582Z","steps":["trace[1718469228] 'process raft request' (duration: 134.390769ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:59:37.917332Z","caller":"traceutil/trace.go:171","msg":"trace[792582730] linearizableReadLoop","detail":"{readStateIndex:5106; appliedIndex:5105; }","duration":"105.021787ms","start":"2026-05-28T13:59:37.812268Z","end":"2026-05-28T13:59:37.91729Z","steps":["trace[792582730] 'read index received' (duration: 9.999147ms)","trace[792582730] 'applied index is now lower than readState.Index' (duration: 95.02107ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T13:59:37.917386Z","caller":"traceutil/trace.go:171","msg":"trace[811604410] transaction","detail":"{read_only:false; response_revision:4918; number_of_response:1; }","duration":"121.691727ms","start":"2026-05-28T13:59:37.795655Z","end":"2026-05-28T13:59:37.917347Z","steps":["trace[811604410] 'process raft request' (duration: 26.653327ms)","trace[811604410] 'compare' (duration: 94.766313ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T13:59:37.918787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.484017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:50 size:2209844"} {"level":"info","ts":"2026-05-28T13:59:37.918892Z","caller":"traceutil/trace.go:171","msg":"trace[1999305546] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:50; response_revision:4918; }","duration":"106.62163ms","start":"2026-05-28T13:59:37.812249Z","end":"2026-05-28T13:59:37.918871Z","steps":["trace[1999305546] 'agreement among raft nodes before linearized reading' (duration: 105.17682ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:59:42.403754Z","caller":"traceutil/trace.go:171","msg":"trace[176526306] transaction","detail":"{read_only:false; response_revision:5081; number_of_response:1; }","duration":"251.641825ms","start":"2026-05-28T13:59:42.152083Z","end":"2026-05-28T13:59:42.403725Z","steps":["trace[176526306] 'process raft request' (duration: 251.49121ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:59:42.433285Z","caller":"traceutil/trace.go:171","msg":"trace[1429797567] linearizableReadLoop","detail":"{readStateIndex:5273; appliedIndex:5271; }","duration":"218.768924ms","start":"2026-05-28T13:59:42.214489Z","end":"2026-05-28T13:59:42.433258Z","steps":["trace[1429797567] 'read index received' (duration: 189.101703ms)","trace[1429797567] 'applied index is now lower than readState.Index' (duration: 29.665981ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T13:59:42.433505Z","caller":"traceutil/trace.go:171","msg":"trace[1852532396] transaction","detail":"{read_only:false; response_revision:5082; number_of_response:1; }","duration":"267.457121ms","start":"2026-05-28T13:59:42.165934Z","end":"2026-05-28T13:59:42.433391Z","steps":["trace[1852532396] 'process raft request' (duration: 267.184424ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:59:42.433571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.070163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-75c0b415-8a64-411c-adec-7407455f6958\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-05-28T13:59:42.43363Z","caller":"traceutil/trace.go:171","msg":"trace[831664768] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-75c0b415-8a64-411c-adec-7407455f6958; range_end:; response_count:1; response_revision:5082; }","duration":"219.176716ms","start":"2026-05-28T13:59:42.214434Z","end":"2026-05-28T13:59:42.433611Z","steps":["trace[831664768] 'agreement among raft nodes before linearized reading' (duration: 218.928589ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:59:53.081801Z","caller":"traceutil/trace.go:171","msg":"trace[874945511] transaction","detail":"{read_only:false; response_revision:5276; number_of_response:1; }","duration":"107.620689ms","start":"2026-05-28T13:59:52.974123Z","end":"2026-05-28T13:59:53.081743Z","steps":["trace[874945511] 'process raft request' (duration: 107.420793ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T13:59:56.768023Z","caller":"traceutil/trace.go:171","msg":"trace[1731751088] linearizableReadLoop","detail":"{readStateIndex:5565; appliedIndex:5564; }","duration":"414.675176ms","start":"2026-05-28T13:59:56.353326Z","end":"2026-05-28T13:59:56.768001Z","steps":["trace[1731751088] 'read index received' (duration: 414.616674ms)","trace[1731751088] 'applied index is now lower than readState.Index' (duration: 57.502µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T13:59:56.768076Z","caller":"traceutil/trace.go:171","msg":"trace[1176041808] transaction","detail":"{read_only:false; response_revision:5364; number_of_response:1; }","duration":"417.595567ms","start":"2026-05-28T13:59:56.350441Z","end":"2026-05-28T13:59:56.768037Z","steps":["trace[1176041808] 'process raft request' (duration: 417.431543ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:59:56.768342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.991865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"warn","ts":"2026-05-28T13:59:56.76838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T13:59:56.350428Z","time spent":"417.877464ms","remote":"127.0.0.1:49702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":840,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T13:59:56.768433Z","caller":"traceutil/trace.go:171","msg":"trace[1638330789] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:5364; }","duration":"415.091307ms","start":"2026-05-28T13:59:56.353321Z","end":"2026-05-28T13:59:56.768413Z","steps":["trace[1638330789] 'agreement among raft nodes before linearized reading' (duration: 414.794959ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:59:56.768484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T13:59:56.353271Z","time spent":"415.20463ms","remote":"127.0.0.1:49808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":1017,"request content":"key:\"/registry/services/specs/monitoring/prometheus-operated\" "} {"level":"info","ts":"2026-05-28T13:59:56.8849Z","caller":"traceutil/trace.go:171","msg":"trace[548372551] transaction","detail":"{read_only:false; response_revision:5365; number_of_response:1; }","duration":"435.274836ms","start":"2026-05-28T13:59:56.449603Z","end":"2026-05-28T13:59:56.884878Z","steps":["trace[548372551] 'process raft request' (duration: 412.793274ms)","trace[548372551] 'compare' (duration: 22.291927ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T13:59:56.885046Z","caller":"traceutil/trace.go:171","msg":"trace[1364703768] linearizableReadLoop","detail":"{readStateIndex:5567; appliedIndex:5565; }","duration":"116.796283ms","start":"2026-05-28T13:59:56.768226Z","end":"2026-05-28T13:59:56.885023Z","steps":["trace[1364703768] 'read index received' (duration: 94.195507ms)","trace[1364703768] 'applied index is now lower than readState.Index' (duration: 22.599696ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T13:59:56.885066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T13:59:56.449581Z","time spent":"435.387939ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T13:59:56.88526Z","caller":"traceutil/trace.go:171","msg":"trace[1048107707] transaction","detail":"{read_only:false; response_revision:5366; number_of_response:1; }","duration":"398.93687ms","start":"2026-05-28T13:59:56.486314Z","end":"2026-05-28T13:59:56.885251Z","steps":["trace[1048107707] 'process raft request' (duration: 398.518649ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:59:56.885364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T13:59:56.486296Z","time spent":"398.991092ms","remote":"127.0.0.1:49892","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-28T13:59:56.885581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.671271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-05-28T13:59:56.88561Z","caller":"traceutil/trace.go:171","msg":"trace[476456434] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:5366; }","duration":"111.733273ms","start":"2026-05-28T13:59:56.77387Z","end":"2026-05-28T13:59:56.885604Z","steps":["trace[476456434] 'agreement among raft nodes before linearized reading' (duration: 111.607719ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:59:56.88558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.755106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-05-28T13:59:56.885704Z","caller":"traceutil/trace.go:171","msg":"trace[1786088445] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:5366; }","duration":"531.930591ms","start":"2026-05-28T13:59:56.353747Z","end":"2026-05-28T13:59:56.885677Z","steps":["trace[1786088445] 'agreement among raft nodes before linearized reading' (duration: 531.5273ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:59:56.88574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.93421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:110659"} {"level":"warn","ts":"2026-05-28T13:59:56.885731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.337764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls-4bwwj\" ","response":"range_response_count:1 size:2596"} {"level":"info","ts":"2026-05-28T13:59:56.885807Z","caller":"traceutil/trace.go:171","msg":"trace[1172064079] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:5366; }","duration":"111.013222ms","start":"2026-05-28T13:59:56.774782Z","end":"2026-05-28T13:59:56.885795Z","steps":["trace[1172064079] 'agreement among raft nodes before linearized reading' (duration: 110.718964ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:59:56.885725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.843625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-zmbrs\" ","response":"range_response_count:1 size:7817"} {"level":"info","ts":"2026-05-28T13:59:56.885972Z","caller":"traceutil/trace.go:171","msg":"trace[715732000] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-zmbrs; range_end:; response_count:1; response_revision:5366; }","duration":"164.144843ms","start":"2026-05-28T13:59:56.721796Z","end":"2026-05-28T13:59:56.88594Z","steps":["trace[715732000] 'agreement among raft nodes before linearized reading' (duration: 163.632449ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:59:56.885774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T13:59:56.353733Z","time spent":"532.028023ms","remote":"127.0.0.1:49808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":1309,"request content":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" "} {"level":"warn","ts":"2026-05-28T13:59:56.88558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.609362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T13:59:56.886095Z","caller":"traceutil/trace.go:171","msg":"trace[2125901350] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:5366; }","duration":"442.209708ms","start":"2026-05-28T13:59:56.443876Z","end":"2026-05-28T13:59:56.886086Z","steps":["trace[2125901350] 'agreement among raft nodes before linearized reading' (duration: 441.54623ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:59:56.886159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T13:59:56.443853Z","time spent":"442.29288ms","remote":"127.0.0.1:53078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-28T13:59:56.886293Z","caller":"traceutil/trace.go:171","msg":"trace[603021687] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls-4bwwj; range_end:; response_count:1; response_revision:5366; }","duration":"527.483408ms","start":"2026-05-28T13:59:56.35834Z","end":"2026-05-28T13:59:56.885823Z","steps":["trace[603021687] 'agreement among raft nodes before linearized reading' (duration: 527.143139ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T13:59:56.886861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T13:59:56.358333Z","time spent":"528.509706ms","remote":"127.0.0.1:49712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":2620,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls-4bwwj\" "} {"level":"warn","ts":"2026-05-28T14:00:03.673341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.238742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-28T14:00:03.673457Z","caller":"traceutil/trace.go:171","msg":"trace[1758287921] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:5522; }","duration":"131.420887ms","start":"2026-05-28T14:00:03.542018Z","end":"2026-05-28T14:00:03.673439Z","steps":["trace[1758287921] 'count revisions from in-memory index tree' (duration: 131.15025ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:00:03.673521Z","caller":"traceutil/trace.go:171","msg":"trace[775676059] transaction","detail":"{read_only:false; response_revision:5523; number_of_response:1; }","duration":"131.043317ms","start":"2026-05-28T14:00:03.542441Z","end":"2026-05-28T14:00:03.673485Z","steps":["trace[775676059] 'process raft request' (duration: 46.103506ms)","trace[775676059] 'compare' (duration: 84.303804ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:01:02.971653Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2965} {"level":"info","ts":"2026-05-28T14:01:03.04253Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2965,"took":"69.289834ms","hash":1632395322,"current-db-size-bytes":58388480,"current-db-size":"58 MB","current-db-size-in-use-bytes":33521664,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-05-28T14:01:03.042632Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1632395322,"revision":2965,"compact-revision":-1} {"level":"info","ts":"2026-05-28T14:06:02.97909Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6033} {"level":"info","ts":"2026-05-28T14:06:03.073758Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6033,"took":"92.507989ms","hash":3073671742,"current-db-size-bytes":58388480,"current-db-size":"58 MB","current-db-size-in-use-bytes":21872640,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-05-28T14:06:03.073855Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3073671742,"revision":6033,"compact-revision":2965} {"level":"info","ts":"2026-05-28T14:06:26.53012Z","caller":"traceutil/trace.go:171","msg":"trace[1735981214] transaction","detail":"{read_only:false; response_revision:8414; number_of_response:1; }","duration":"169.386337ms","start":"2026-05-28T14:06:26.360706Z","end":"2026-05-28T14:06:26.530092Z","steps":["trace[1735981214] 'process raft request' (duration: 167.656229ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:06:26.530207Z","caller":"traceutil/trace.go:171","msg":"trace[1254327353] transaction","detail":"{read_only:false; response_revision:8416; number_of_response:1; }","duration":"114.389242ms","start":"2026-05-28T14:06:26.415796Z","end":"2026-05-28T14:06:26.530185Z","steps":["trace[1254327353] 'process raft request' (duration: 114.34528ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:06:26.530271Z","caller":"traceutil/trace.go:171","msg":"trace[750160294] transaction","detail":"{read_only:false; response_revision:8415; number_of_response:1; }","duration":"114.529456ms","start":"2026-05-28T14:06:26.415726Z","end":"2026-05-28T14:06:26.530256Z","steps":["trace[750160294] 'process raft request' (duration: 114.31351ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:06:38.813078Z","caller":"traceutil/trace.go:171","msg":"trace[1622097874] transaction","detail":"{read_only:false; response_revision:8475; number_of_response:1; }","duration":"235.943048ms","start":"2026-05-28T14:06:38.57711Z","end":"2026-05-28T14:06:38.813053Z","steps":["trace[1622097874] 'process raft request' (duration: 235.787154ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:06:38.840392Z","caller":"traceutil/trace.go:171","msg":"trace[27732266] transaction","detail":"{read_only:false; response_revision:8476; number_of_response:1; }","duration":"260.481242ms","start":"2026-05-28T14:06:38.579883Z","end":"2026-05-28T14:06:38.840364Z","steps":["trace[27732266] 'process raft request' (duration: 260.307937ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:07:07.113517Z","caller":"traceutil/trace.go:171","msg":"trace[946139297] transaction","detail":"{read_only:false; response_revision:8682; number_of_response:1; }","duration":"317.664672ms","start":"2026-05-28T14:07:06.795825Z","end":"2026-05-28T14:07:07.11349Z","steps":["trace[946139297] 'process raft request' (duration: 317.520708ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:07:07.113927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:07:06.7958Z","time spent":"317.830507ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T14:07:07.186723Z","caller":"traceutil/trace.go:171","msg":"trace[2106041910] transaction","detail":"{read_only:false; response_revision:8683; number_of_response:1; }","duration":"265.84378ms","start":"2026-05-28T14:07:06.920856Z","end":"2026-05-28T14:07:07.1867Z","steps":["trace[2106041910] 'process raft request' (duration: 265.672225ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:07:07.186966Z","caller":"traceutil/trace.go:171","msg":"trace[1008171005] transaction","detail":"{read_only:false; response_revision:8684; number_of_response:1; }","duration":"251.324721ms","start":"2026-05-28T14:07:06.935609Z","end":"2026-05-28T14:07:07.186933Z","steps":["trace[1008171005] 'process raft request' (duration: 251.036063ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:07:07.187113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.476532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-28T14:07:07.187295Z","caller":"traceutil/trace.go:171","msg":"trace[1598867893] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:8684; }","duration":"158.699488ms","start":"2026-05-28T14:07:07.028577Z","end":"2026-05-28T14:07:07.187277Z","steps":["trace[1598867893] 'agreement among raft nodes before linearized reading' (duration: 158.453471ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:07:07.187711Z","caller":"traceutil/trace.go:171","msg":"trace[804401783] linearizableReadLoop","detail":"{readStateIndex:8992; appliedIndex:8989; }","duration":"158.259786ms","start":"2026-05-28T14:07:07.028617Z","end":"2026-05-28T14:07:07.186876Z","steps":["trace[804401783] 'read index received' (duration: 84.649124ms)","trace[804401783] 'applied index is now lower than readState.Index' (duration: 73.608782ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:07:10.691222Z","caller":"traceutil/trace.go:171","msg":"trace[1345336413] transaction","detail":"{read_only:false; response_revision:8702; number_of_response:1; }","duration":"237.380109ms","start":"2026-05-28T14:07:10.453817Z","end":"2026-05-28T14:07:10.691197Z","steps":["trace[1345336413] 'process raft request' (duration: 237.243455ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:07:19.541707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.648417ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T14:07:19.54191Z","caller":"traceutil/trace.go:171","msg":"trace[577953365] transaction","detail":"{read_only:false; response_revision:8789; number_of_response:1; }","duration":"222.51779ms","start":"2026-05-28T14:07:19.319378Z","end":"2026-05-28T14:07:19.541896Z","steps":["trace[577953365] 'process raft request' (duration: 222.409207ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:07:19.541881Z","caller":"traceutil/trace.go:171","msg":"trace[254199347] transaction","detail":"{read_only:false; response_revision:8788; number_of_response:1; }","duration":"299.775712ms","start":"2026-05-28T14:07:19.24207Z","end":"2026-05-28T14:07:19.541845Z","steps":["trace[254199347] 'process raft request' (duration: 160.917689ms)","trace[254199347] 'compare' (duration: 138.462792ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:07:19.541996Z","caller":"traceutil/trace.go:171","msg":"trace[1759654465] linearizableReadLoop","detail":"{readStateIndex:9101; appliedIndex:9100; }","duration":"231.122997ms","start":"2026-05-28T14:07:19.310789Z","end":"2026-05-28T14:07:19.541912Z","steps":["trace[1759654465] 'read index received' (duration: 93.629321ms)","trace[1759654465] 'applied index is now lower than readState.Index' (duration: 137.490876ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:07:19.542421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.63155ms","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-28T14:07:19.542511Z","caller":"traceutil/trace.go:171","msg":"trace[714909250] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8789; }","duration":"231.724243ms","start":"2026-05-28T14:07:19.310774Z","end":"2026-05-28T14:07:19.542498Z","steps":["trace[714909250] 'agreement among raft nodes before linearized reading' (duration: 231.359023ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:07:19.584629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.581066ms","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-28T14:07:19.584707Z","caller":"traceutil/trace.go:171","msg":"trace[1951124680] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8790; }","duration":"173.693899ms","start":"2026-05-28T14:07:19.410995Z","end":"2026-05-28T14:07:19.584689Z","steps":["trace[1951124680] 'agreement among raft nodes before linearized reading' (duration: 173.521535ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:07:19.584683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.700702ms","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-28T14:07:19.584867Z","caller":"traceutil/trace.go:171","msg":"trace[1237756081] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8790; }","duration":"243.855217ms","start":"2026-05-28T14:07:19.340917Z","end":"2026-05-28T14:07:19.584773Z","steps":["trace[1237756081] 'agreement among raft nodes before linearized reading' (duration: 243.551058ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:07:19.585052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.848926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-28T14:07:19.585115Z","caller":"traceutil/trace.go:171","msg":"trace[1123039283] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:8790; }","duration":"255.958329ms","start":"2026-05-28T14:07:19.329142Z","end":"2026-05-28T14:07:19.5851Z","steps":["trace[1123039283] 'agreement among raft nodes before linearized reading' (duration: 255.795774ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:07:34.689607Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000240d.wal"} {"level":"warn","ts":"2026-05-28T14:08:42.397611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.294924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-28T14:08:42.397683Z","caller":"traceutil/trace.go:171","msg":"trace[608639155] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:9580; }","duration":"119.426958ms","start":"2026-05-28T14:08:42.27824Z","end":"2026-05-28T14:08:42.397667Z","steps":["trace[608639155] 'count revisions from in-memory index tree' (duration: 119.171851ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:08:42.397892Z","caller":"traceutil/trace.go:171","msg":"trace[965096873] transaction","detail":"{read_only:false; response_revision:9581; number_of_response:1; }","duration":"109.422952ms","start":"2026-05-28T14:08:42.28844Z","end":"2026-05-28T14:08:42.397863Z","steps":["trace[965096873] 'process raft request' (duration: 35.258514ms)","trace[965096873] 'compare' (duration: 73.935722ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:08:53.976005Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c47ca1a7b1fe506b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-28T14:08:53.983452Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-28T14:08:53.983608Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-05-28T14:11:02.990607Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8154} {"level":"info","ts":"2026-05-28T14:11:03.052345Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8154,"took":"59.288499ms","hash":683509242,"current-db-size-bytes":58388480,"current-db-size":"58 MB","current-db-size-in-use-bytes":27967488,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-28T14:11:03.052408Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":683509242,"revision":8154,"compact-revision":6033} {"level":"warn","ts":"2026-05-28T14:14:15.808414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.489132ms","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-28T14:14:15.808502Z","caller":"traceutil/trace.go:171","msg":"trace[1552440810] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11975; }","duration":"104.620435ms","start":"2026-05-28T14:14:15.703865Z","end":"2026-05-28T14:14:15.808485Z","steps":["trace[1552440810] 'range keys from in-memory index tree' (duration: 104.318547ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:14:16.071964Z","caller":"traceutil/trace.go:171","msg":"trace[995272242] transaction","detail":"{read_only:false; response_revision:11978; number_of_response:1; }","duration":"122.288213ms","start":"2026-05-28T14:14:15.94965Z","end":"2026-05-28T14:14:16.071938Z","steps":["trace[995272242] 'process raft request' (duration: 122.131088ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:14:16.131997Z","caller":"traceutil/trace.go:171","msg":"trace[445762567] transaction","detail":"{read_only:false; response_revision:11979; number_of_response:1; }","duration":"182.278088ms","start":"2026-05-28T14:14:15.949704Z","end":"2026-05-28T14:14:16.131982Z","steps":["trace[445762567] 'process raft request' (duration: 182.153964ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:14:16.132283Z","caller":"traceutil/trace.go:171","msg":"trace[2115414601] transaction","detail":"{read_only:false; response_revision:11980; number_of_response:1; }","duration":"182.204006ms","start":"2026-05-28T14:14:15.950037Z","end":"2026-05-28T14:14:16.132241Z","steps":["trace[2115414601] 'process raft request' (duration: 181.911638ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:14:16.13231Z","caller":"traceutil/trace.go:171","msg":"trace[294374332] transaction","detail":"{read_only:false; response_revision:11981; number_of_response:1; }","duration":"179.618164ms","start":"2026-05-28T14:14:15.952669Z","end":"2026-05-28T14:14:16.132288Z","steps":["trace[294374332] 'process raft request' (duration: 179.48159ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:16:02.996741Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10523} {"level":"info","ts":"2026-05-28T14:16:03.074428Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10523,"took":"75.348537ms","hash":2935294975,"current-db-size-bytes":58388480,"current-db-size":"58 MB","current-db-size-in-use-bytes":25960448,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-05-28T14:16:03.074498Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2935294975,"revision":10523,"compact-revision":8154} {"level":"info","ts":"2026-05-28T14:20:43.599789Z","caller":"traceutil/trace.go:171","msg":"trace[907836432] linearizableReadLoop","detail":"{readStateIndex:15084; appliedIndex:15083; }","duration":"185.775558ms","start":"2026-05-28T14:20:43.413988Z","end":"2026-05-28T14:20:43.599763Z","steps":["trace[907836432] 'read index received' (duration: 185.559652ms)","trace[907836432] 'applied index is now lower than readState.Index' (duration: 214.786µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:20:43.599864Z","caller":"traceutil/trace.go:171","msg":"trace[1741231536] transaction","detail":"{read_only:false; response_revision:14578; number_of_response:1; }","duration":"217.501239ms","start":"2026-05-28T14:20:43.382319Z","end":"2026-05-28T14:20:43.59982Z","steps":["trace[1741231536] 'process raft request' (duration: 217.265422ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:20:43.599938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.916352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/openstack/ovn-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T14:20:43.60004Z","caller":"traceutil/trace.go:171","msg":"trace[203988096] range","detail":"{range_begin:/registry/daemonsets/openstack/ovn-controller; range_end:; response_count:0; response_revision:14578; }","duration":"186.019725ms","start":"2026-05-28T14:20:43.413951Z","end":"2026-05-28T14:20:43.599971Z","steps":["trace[203988096] 'agreement among raft nodes before linearized reading' (duration: 185.918212ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:20:50.780707Z","caller":"traceutil/trace.go:171","msg":"trace[641223237] transaction","detail":"{read_only:false; response_revision:14631; number_of_response:1; }","duration":"122.1065ms","start":"2026-05-28T14:20:50.658575Z","end":"2026-05-28T14:20:50.780681Z","steps":["trace[641223237] 'process raft request' (duration: 102.349488ms)","trace[641223237] 'compare' (duration: 19.568487ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:21:03.003324Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12705} {"level":"info","ts":"2026-05-28T14:21:03.076454Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12705,"took":"71.091091ms","hash":2029389250,"current-db-size-bytes":58388480,"current-db-size":"58 MB","current-db-size-in-use-bytes":28606464,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-28T14:21:03.076518Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2029389250,"revision":12705,"compact-revision":10523} {"level":"info","ts":"2026-05-28T14:26:03.01094Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14948} {"level":"info","ts":"2026-05-28T14:26:03.109953Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14948,"took":"95.848059ms","hash":3088994976,"current-db-size-bytes":58388480,"current-db-size":"58 MB","current-db-size-in-use-bytes":30724096,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-28T14:26:03.11003Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3088994976,"revision":14948,"compact-revision":12705} {"level":"info","ts":"2026-05-28T14:28:13.930932Z","caller":"traceutil/trace.go:171","msg":"trace[576708384] linearizableReadLoop","detail":"{readStateIndex:19083; appliedIndex:19082; }","duration":"153.687534ms","start":"2026-05-28T14:28:13.777218Z","end":"2026-05-28T14:28:13.930906Z","steps":["trace[576708384] 'read index received' (duration: 153.416956ms)","trace[576708384] 'applied index is now lower than readState.Index' (duration: 269.558µs)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:28:13.931176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.94904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-x4r8p\" ","response":"range_response_count:1 size:22122"} {"level":"info","ts":"2026-05-28T14:28:13.931217Z","caller":"traceutil/trace.go:171","msg":"trace[2067628731] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-x4r8p; range_end:; response_count:1; response_revision:18454; }","duration":"154.044223ms","start":"2026-05-28T14:28:13.777161Z","end":"2026-05-28T14:28:13.931206Z","steps":["trace[2067628731] 'agreement among raft nodes before linearized reading' (duration: 153.858128ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:28:13.931323Z","caller":"traceutil/trace.go:171","msg":"trace[1484700693] transaction","detail":"{read_only:false; response_revision:18454; number_of_response:1; }","duration":"177.462389ms","start":"2026-05-28T14:28:13.753846Z","end":"2026-05-28T14:28:13.931308Z","steps":["trace[1484700693] 'process raft request' (duration: 176.863902ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:28:20.277451Z","caller":"traceutil/trace.go:171","msg":"trace[1617224448] transaction","detail":"{read_only:false; response_revision:18493; number_of_response:1; }","duration":"159.975157ms","start":"2026-05-28T14:28:20.117455Z","end":"2026-05-28T14:28:20.27743Z","steps":["trace[1617224448] 'process raft request' (duration: 159.682579ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:28:21.236697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.534844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:28:21.236882Z","caller":"traceutil/trace.go:171","msg":"trace[71254378] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:18498; }","duration":"180.76814ms","start":"2026-05-28T14:28:21.056074Z","end":"2026-05-28T14:28:21.236842Z","steps":["trace[71254378] 'count revisions from in-memory index tree' (duration: 180.437711ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:28:21.236935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.348924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:28:21.237043Z","caller":"traceutil/trace.go:171","msg":"trace[1807256159] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18498; }","duration":"137.502368ms","start":"2026-05-28T14:28:21.099515Z","end":"2026-05-28T14:28:21.237018Z","steps":["trace[1807256159] 'range keys from in-memory index tree' (duration: 137.240131ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:28:21.237174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.200728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-28T14:28:21.237321Z","caller":"traceutil/trace.go:171","msg":"trace[156082430] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:18498; }","duration":"203.412793ms","start":"2026-05-28T14:28:21.033881Z","end":"2026-05-28T14:28:21.237293Z","steps":["trace[156082430] 'count revisions from in-memory index tree' (duration: 203.092705ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:29:45.048708Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c47ca1a7b1fe506b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-28T14:29:45.055562Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-05-28T14:29:45.055743Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-05-28T14:31:03.016889Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17454} {"level":"info","ts":"2026-05-28T14:31:03.117439Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17454,"took":"95.962963ms","hash":396268025,"current-db-size-bytes":58388480,"current-db-size":"58 MB","current-db-size-in-use-bytes":35094528,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-05-28T14:31:03.117515Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":396268025,"revision":17454,"compact-revision":14948} {"level":"info","ts":"2026-05-28T14:33:33.848659Z","caller":"traceutil/trace.go:171","msg":"trace[1025440928] transaction","detail":"{read_only:false; response_revision:20912; number_of_response:1; }","duration":"164.964293ms","start":"2026-05-28T14:33:33.683649Z","end":"2026-05-28T14:33:33.848613Z","steps":["trace[1025440928] 'process raft request' (duration: 164.786728ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:33:34.314626Z","caller":"traceutil/trace.go:171","msg":"trace[538426917] linearizableReadLoop","detail":"{readStateIndex:21627; appliedIndex:21625; }","duration":"420.829509ms","start":"2026-05-28T14:33:33.893768Z","end":"2026-05-28T14:33:34.314597Z","steps":["trace[538426917] 'read index received' (duration: 365.387582ms)","trace[538426917] 'applied index is now lower than readState.Index' (duration: 55.440727ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:33:34.314966Z","caller":"traceutil/trace.go:171","msg":"trace[579887950] transaction","detail":"{read_only:false; response_revision:20913; number_of_response:1; }","duration":"461.86526ms","start":"2026-05-28T14:33:33.853075Z","end":"2026-05-28T14:33:34.31494Z","steps":["trace[579887950] 'process raft request' (duration: 406.153195ms)","trace[579887950] 'compare' (duration: 55.17866ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:33:34.315098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:33:33.85303Z","time spent":"461.984263ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T14:33:34.31511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.301903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:33:34.315262Z","caller":"traceutil/trace.go:171","msg":"trace[575379182] transaction","detail":"{read_only:false; response_revision:20914; number_of_response:1; }","duration":"444.06569ms","start":"2026-05-28T14:33:33.871169Z","end":"2026-05-28T14:33:34.315234Z","steps":["trace[575379182] 'process raft request' (duration: 443.374081ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:33:34.315363Z","caller":"traceutil/trace.go:171","msg":"trace[1872408597] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:20914; }","duration":"421.573341ms","start":"2026-05-28T14:33:33.893726Z","end":"2026-05-28T14:33:34.315299Z","steps":["trace[1872408597] 'agreement among raft nodes before linearized reading' (duration: 421.18209ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:33:34.315429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:33:33.871142Z","time spent":"444.197773ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T14:33:34.31544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.604477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-05-28T14:33:34.315451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.530865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-28T14:33:34.31558Z","caller":"traceutil/trace.go:171","msg":"trace[2032458759] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20914; }","duration":"276.70529ms","start":"2026-05-28T14:33:34.038844Z","end":"2026-05-28T14:33:34.31555Z","steps":["trace[2032458759] 'agreement among raft nodes before linearized reading' (duration: 276.418483ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:33:34.315591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:33:33.89371Z","time spent":"421.759225ms","remote":"127.0.0.1:53120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-05-28T14:33:34.315488Z","caller":"traceutil/trace.go:171","msg":"trace[2058181407] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20914; }","duration":"276.688339ms","start":"2026-05-28T14:33:34.038787Z","end":"2026-05-28T14:33:34.315476Z","steps":["trace[2058181407] 'agreement among raft nodes before linearized reading' (duration: 276.500404ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:33:34.315583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.341994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:33:34.315886Z","caller":"traceutil/trace.go:171","msg":"trace[1396912480] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20914; }","duration":"222.712584ms","start":"2026-05-28T14:33:34.093155Z","end":"2026-05-28T14:33:34.315868Z","steps":["trace[1396912480] 'agreement among raft nodes before linearized reading' (duration: 222.103947ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:34:21.748564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.274569ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-05-28T14:34:21.875067Z","caller":"traceutil/trace.go:171","msg":"trace[444644421] transaction","detail":"{read_only:false; response_revision:21157; number_of_response:1; }","duration":"119.177652ms","start":"2026-05-28T14:34:21.755858Z","end":"2026-05-28T14:34:21.875036Z","steps":["trace[444644421] 'process raft request' (duration: 103.262954ms)","trace[444644421] 'compare' (duration: 15.777135ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:34:22.111128Z","caller":"traceutil/trace.go:171","msg":"trace[495231712] linearizableReadLoop","detail":"{readStateIndex:21882; appliedIndex:21881; }","duration":"137.62217ms","start":"2026-05-28T14:34:21.973488Z","end":"2026-05-28T14:34:22.11111Z","steps":["trace[495231712] 'read index received' (duration: 137.451356ms)","trace[495231712] 'applied index is now lower than readState.Index' (duration: 169.994µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:34:22.111236Z","caller":"traceutil/trace.go:171","msg":"trace[1303723021] transaction","detail":"{read_only:false; response_revision:21158; number_of_response:1; }","duration":"192.537553ms","start":"2026-05-28T14:34:21.918671Z","end":"2026-05-28T14:34:22.111209Z","steps":["trace[1303723021] 'process raft request' (duration: 192.318247ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:34:22.111313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.781325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:34:22.111359Z","caller":"traceutil/trace.go:171","msg":"trace[282003453] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:21158; }","duration":"137.877048ms","start":"2026-05-28T14:34:21.97347Z","end":"2026-05-28T14:34:22.111347Z","steps":["trace[282003453] 'agreement among raft nodes before linearized reading' (duration: 137.746124ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:36:03.024279Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19861} {"level":"info","ts":"2026-05-28T14:36:03.134718Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19861,"took":"106.752171ms","hash":603408355,"current-db-size-bytes":58388480,"current-db-size":"58 MB","current-db-size-in-use-bytes":29450240,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-28T14:36:03.134787Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":603408355,"revision":19861,"compact-revision":17454} {"level":"info","ts":"2026-05-28T14:41:03.031369Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22032} {"level":"info","ts":"2026-05-28T14:41:03.139336Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22032,"took":"103.314895ms","hash":3631263854,"current-db-size-bytes":58388480,"current-db-size":"58 MB","current-db-size-in-use-bytes":42975232,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-05-28T14:41:03.139423Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3631263854,"revision":22032,"compact-revision":19861} {"level":"warn","ts":"2026-05-28T14:41:50.632247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.370201ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-28T14:41:50.632487Z","caller":"traceutil/trace.go:171","msg":"trace[29150587] transaction","detail":"{read_only:false; response_revision:25730; number_of_response:1; }","duration":"478.675058ms","start":"2026-05-28T14:41:50.153793Z","end":"2026-05-28T14:41:50.632468Z","steps":["trace[29150587] 'process raft request' (duration: 478.575695ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:41:50.632486Z","caller":"traceutil/trace.go:171","msg":"trace[704569451] transaction","detail":"{read_only:false; response_revision:25729; number_of_response:1; }","duration":"564.186931ms","start":"2026-05-28T14:41:50.06825Z","end":"2026-05-28T14:41:50.632436Z","steps":["trace[704569451] 'process raft request' (duration: 204.536382ms)","trace[704569451] 'compare' (duration: 358.876447ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:41:50.632511Z","caller":"traceutil/trace.go:171","msg":"trace[346715542] linearizableReadLoop","detail":"{readStateIndex:26585; appliedIndex:26583; }","duration":"539.036446ms","start":"2026-05-28T14:41:50.093448Z","end":"2026-05-28T14:41:50.632484Z","steps":["trace[346715542] 'read index received' (duration: 43.460071ms)","trace[346715542] 'applied index is now lower than readState.Index' (duration: 495.573235ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:41:50.632565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:50.153776Z","time spent":"478.75543ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T14:41:50.632668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.211011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-28T14:41:50.632668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:50.068231Z","time spent":"564.336545ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T14:41:50.632703Z","caller":"traceutil/trace.go:171","msg":"trace[1857784883] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25730; }","duration":"539.287923ms","start":"2026-05-28T14:41:50.093405Z","end":"2026-05-28T14:41:50.632693Z","steps":["trace[1857784883] 'agreement among raft nodes before linearized reading' (duration: 539.205131ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:50.632733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:50.093385Z","time spent":"539.341675ms","remote":"127.0.0.1:49630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-28T14:41:50.632838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.734923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-05-28T14:41:50.632844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.292083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-05-28T14:41:50.632882Z","caller":"traceutil/trace.go:171","msg":"trace[1815173216] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25730; }","duration":"168.804465ms","start":"2026-05-28T14:41:50.464063Z","end":"2026-05-28T14:41:50.632867Z","steps":["trace[1815173216] 'agreement among raft nodes before linearized reading' (duration: 168.616059ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:41:50.632908Z","caller":"traceutil/trace.go:171","msg":"trace[1287422342] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25730; }","duration":"226.401226ms","start":"2026-05-28T14:41:50.406489Z","end":"2026-05-28T14:41:50.632891Z","steps":["trace[1287422342] 'agreement among raft nodes before linearized reading' (duration: 226.18027ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:50.920566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.734971ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-28T14:41:50.920866Z","caller":"traceutil/trace.go:171","msg":"trace[254591540] linearizableReadLoop","detail":"{readStateIndex:26588; appliedIndex:26586; }","duration":"167.675994ms","start":"2026-05-28T14:41:50.753167Z","end":"2026-05-28T14:41:50.920843Z","steps":["trace[254591540] 'read index received' (duration: 14.562553ms)","trace[254591540] 'applied index is now lower than readState.Index' (duration: 153.109491ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:41:50.920955Z","caller":"traceutil/trace.go:171","msg":"trace[1092921636] transaction","detail":"{read_only:false; response_revision:25732; number_of_response:1; }","duration":"282.352793ms","start":"2026-05-28T14:41:50.638572Z","end":"2026-05-28T14:41:50.920925Z","steps":["trace[1092921636] 'process raft request' (duration: 282.153277ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:41:50.920959Z","caller":"traceutil/trace.go:171","msg":"trace[1100651809] transaction","detail":"{read_only:false; response_revision:25731; number_of_response:1; }","duration":"282.946699ms","start":"2026-05-28T14:41:50.637965Z","end":"2026-05-28T14:41:50.920912Z","steps":["trace[1100651809] 'process raft request' (duration: 129.754795ms)","trace[1100651809] 'compare' (duration: 152.583287ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:41:50.921255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.086356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-05-28T14:41:50.921312Z","caller":"traceutil/trace.go:171","msg":"trace[2114075366] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25732; }","duration":"168.197678ms","start":"2026-05-28T14:41:50.753099Z","end":"2026-05-28T14:41:50.921297Z","steps":["trace[2114075366] 'agreement among raft nodes before linearized reading' (duration: 167.847769ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:41:51.262152Z","caller":"traceutil/trace.go:171","msg":"trace[584073978] transaction","detail":"{read_only:false; response_revision:25734; number_of_response:1; }","duration":"369.551343ms","start":"2026-05-28T14:41:50.892571Z","end":"2026-05-28T14:41:51.262123Z","steps":["trace[584073978] 'process raft request' (duration: 294.676874ms)","trace[584073978] 'compare' (duration: 74.535249ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:41:51.262254Z","caller":"traceutil/trace.go:171","msg":"trace[1576325161] transaction","detail":"{read_only:false; response_revision:25735; number_of_response:1; }","duration":"336.043767ms","start":"2026-05-28T14:41:50.926181Z","end":"2026-05-28T14:41:51.262225Z","steps":["trace[1576325161] 'process raft request' (duration: 335.876222ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:51.262301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:50.89254Z","time spent":"369.676576ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T14:41:51.262359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.024739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-05-28T14:41:51.262175Z","caller":"traceutil/trace.go:171","msg":"trace[1010617183] linearizableReadLoop","detail":"{readStateIndex:26590; appliedIndex:26588; }","duration":"341.24931ms","start":"2026-05-28T14:41:50.92091Z","end":"2026-05-28T14:41:51.262159Z","steps":["trace[1010617183] 'read index received' (duration: 26.43235ms)","trace[1010617183] 'applied index is now lower than readState.Index' (duration: 314.81568ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:41:51.262396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:50.926156Z","time spent":"336.160399ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T14:41:51.262414Z","caller":"traceutil/trace.go:171","msg":"trace[1009055081] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25735; }","duration":"453.123961ms","start":"2026-05-28T14:41:50.809276Z","end":"2026-05-28T14:41:51.2624Z","steps":["trace[1009055081] 'agreement among raft nodes before linearized reading' (duration: 452.932156ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:51.262449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:50.809253Z","time spent":"453.188944ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-28T14:41:51.26247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.414042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-28T14:41:51.262554Z","caller":"traceutil/trace.go:171","msg":"trace[1792916253] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25735; }","duration":"452.553446ms","start":"2026-05-28T14:41:50.809984Z","end":"2026-05-28T14:41:51.262537Z","steps":["trace[1792916253] 'agreement among raft nodes before linearized reading' (duration: 452.298009ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:51.262602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:50.809964Z","time spent":"452.629938ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-28T14:41:51.284198Z","caller":"traceutil/trace.go:171","msg":"trace[132053185] transaction","detail":"{read_only:false; response_revision:25736; number_of_response:1; }","duration":"140.239425ms","start":"2026-05-28T14:41:51.143938Z","end":"2026-05-28T14:41:51.284177Z","steps":["trace[132053185] 'process raft request' (duration: 140.141033ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:51.284371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.225867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:41:51.284417Z","caller":"traceutil/trace.go:171","msg":"trace[1211727618] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25736; }","duration":"190.3098ms","start":"2026-05-28T14:41:51.094094Z","end":"2026-05-28T14:41:51.284404Z","steps":["trace[1211727618] 'agreement among raft nodes before linearized reading' (duration: 190.188546ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:51.685083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.230395ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-28T14:41:51.685187Z","caller":"traceutil/trace.go:171","msg":"trace[1848811594] transaction","detail":"{read_only:false; response_revision:25739; number_of_response:1; }","duration":"186.442001ms","start":"2026-05-28T14:41:51.498726Z","end":"2026-05-28T14:41:51.685168Z","steps":["trace[1848811594] 'process raft request' (duration: 63.043632ms)","trace[1848811594] 'compare' (duration: 122.751122ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:41:51.967629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.362843ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-28T14:41:51.96784Z","caller":"traceutil/trace.go:171","msg":"trace[2008195357] transaction","detail":"{read_only:false; response_revision:25740; number_of_response:1; }","duration":"446.549799ms","start":"2026-05-28T14:41:51.521259Z","end":"2026-05-28T14:41:51.967809Z","steps":["trace[2008195357] 'process raft request' (duration: 277.927049ms)","trace[2008195357] 'compare' (duration: 168.27239ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:41:51.967984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:51.521232Z","time spent":"446.675923ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T14:41:51.967968Z","caller":"traceutil/trace.go:171","msg":"trace[1748040579] transaction","detail":"{read_only:false; response_revision:25741; number_of_response:1; }","duration":"407.819719ms","start":"2026-05-28T14:41:51.560121Z","end":"2026-05-28T14:41:51.967941Z","steps":["trace[1748040579] 'process raft request' (duration: 407.599183ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:51.9681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:51.560087Z","time spent":"407.942132ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T14:41:52.109406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.612334ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-05-28T14:41:52.109497Z","caller":"traceutil/trace.go:171","msg":"trace[86344897] linearizableReadLoop","detail":"{readStateIndex:26598; appliedIndex:26595; }","duration":"406.01908ms","start":"2026-05-28T14:41:51.70346Z","end":"2026-05-28T14:41:52.10948Z","steps":["trace[86344897] 'read index received' (duration: 95.715195ms)","trace[86344897] 'applied index is now lower than readState.Index' (duration: 310.302355ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:41:52.109728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.258207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-05-28T14:41:52.109818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.810655ms","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-28T14:41:52.109858Z","caller":"traceutil/trace.go:171","msg":"trace[247677333] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25741; }","duration":"282.889027ms","start":"2026-05-28T14:41:51.826959Z","end":"2026-05-28T14:41:52.109848Z","steps":["trace[247677333] 'agreement among raft nodes before linearized reading' (duration: 282.727823ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:41:52.109825Z","caller":"traceutil/trace.go:171","msg":"trace[1380679021] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:25741; }","duration":"406.421531ms","start":"2026-05-28T14:41:51.703386Z","end":"2026-05-28T14:41:52.109808Z","steps":["trace[1380679021] 'agreement among raft nodes before linearized reading' (duration: 406.278247ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:52.109947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:51.70336Z","time spent":"406.576156ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":6,"response size":32,"request content":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true "} {"level":"warn","ts":"2026-05-28T14:41:57.570168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.015063ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-28T14:41:57.570279Z","caller":"traceutil/trace.go:171","msg":"trace[1284844864] linearizableReadLoop","detail":"{readStateIndex:26642; appliedIndex:26641; }","duration":"255.574022ms","start":"2026-05-28T14:41:57.314689Z","end":"2026-05-28T14:41:57.570263Z","steps":["trace[1284844864] 'read index received' (duration: 121.371134ms)","trace[1284844864] 'applied index is now lower than readState.Index' (duration: 134.201768ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:41:57.570519Z","caller":"traceutil/trace.go:171","msg":"trace[704717869] transaction","detail":"{read_only:false; response_revision:25784; number_of_response:1; }","duration":"267.581294ms","start":"2026-05-28T14:41:57.302924Z","end":"2026-05-28T14:41:57.570505Z","steps":["trace[704717869] 'process raft request' (duration: 133.146429ms)","trace[704717869] 'compare' (duration: 133.909611ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:41:57.570851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.667683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-28T14:41:57.570873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.112001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-05-28T14:41:57.570914Z","caller":"traceutil/trace.go:171","msg":"trace[893547585] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25784; }","duration":"256.778866ms","start":"2026-05-28T14:41:57.314122Z","end":"2026-05-28T14:41:57.570901Z","steps":["trace[893547585] 'agreement among raft nodes before linearized reading' (duration: 256.56965ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:41:57.570917Z","caller":"traceutil/trace.go:171","msg":"trace[1806674458] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:25784; }","duration":"208.188083ms","start":"2026-05-28T14:41:57.362719Z","end":"2026-05-28T14:41:57.570907Z","steps":["trace[1806674458] 'agreement among raft nodes before linearized reading' (duration: 208.05887ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:57.571009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.97455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:41:57.571108Z","caller":"traceutil/trace.go:171","msg":"trace[93749458] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25784; }","duration":"253.070383ms","start":"2026-05-28T14:41:57.318008Z","end":"2026-05-28T14:41:57.571078Z","steps":["trace[93749458] 'agreement among raft nodes before linearized reading' (duration: 252.920729ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:57.571022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.873415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-05-28T14:41:57.571207Z","caller":"traceutil/trace.go:171","msg":"trace[1636793398] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25784; }","duration":"284.108281ms","start":"2026-05-28T14:41:57.287087Z","end":"2026-05-28T14:41:57.571195Z","steps":["trace[1636793398] 'agreement among raft nodes before linearized reading' (duration: 283.724821ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:57.571242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.727247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-05-28T14:41:57.571318Z","caller":"traceutil/trace.go:171","msg":"trace[501700894] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25784; }","duration":"255.883381ms","start":"2026-05-28T14:41:57.315424Z","end":"2026-05-28T14:41:57.571307Z","steps":["trace[501700894] 'agreement among raft nodes before linearized reading' (duration: 255.09688ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:57.571516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.019229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1987"} {"level":"info","ts":"2026-05-28T14:41:57.571585Z","caller":"traceutil/trace.go:171","msg":"trace[2054664091] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:25784; }","duration":"174.115891ms","start":"2026-05-28T14:41:57.397454Z","end":"2026-05-28T14:41:57.571569Z","steps":["trace[2054664091] 'agreement among raft nodes before linearized reading' (duration: 173.175295ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:41:57.76691Z","caller":"traceutil/trace.go:171","msg":"trace[1232087523] transaction","detail":"{read_only:false; response_revision:25785; number_of_response:1; }","duration":"188.264593ms","start":"2026-05-28T14:41:57.578353Z","end":"2026-05-28T14:41:57.766617Z","steps":["trace[1232087523] 'process raft request' (duration: 188.109048ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:41:57.992848Z","caller":"traceutil/trace.go:171","msg":"trace[1868173950] transaction","detail":"{read_only:false; response_revision:25786; number_of_response:1; }","duration":"414.412542ms","start":"2026-05-28T14:41:57.578414Z","end":"2026-05-28T14:41:57.992826Z","steps":["trace[1868173950] 'process raft request' (duration: 335.236274ms)","trace[1868173950] 'compare' (duration: 79.014793ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:41:57.992996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:57.578409Z","time spent":"414.524256ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T14:41:57.9932Z","caller":"traceutil/trace.go:171","msg":"trace[403483110] linearizableReadLoop","detail":"{readStateIndex:26645; appliedIndex:26643; }","duration":"414.563117ms","start":"2026-05-28T14:41:57.578617Z","end":"2026-05-28T14:41:57.99318Z","steps":["trace[403483110] 'read index received' (duration: 188.020926ms)","trace[403483110] 'applied index is now lower than readState.Index' (duration: 226.541311ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:41:57.993284Z","caller":"traceutil/trace.go:171","msg":"trace[2013894685] transaction","detail":"{read_only:false; response_revision:25788; number_of_response:1; }","duration":"409.073224ms","start":"2026-05-28T14:41:57.584164Z","end":"2026-05-28T14:41:57.993238Z","steps":["trace[2013894685] 'process raft request' (duration: 408.778836ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:41:57.99335Z","caller":"traceutil/trace.go:171","msg":"trace[1750400631] transaction","detail":"{read_only:false; response_revision:25789; number_of_response:1; }","duration":"409.039244ms","start":"2026-05-28T14:41:57.584255Z","end":"2026-05-28T14:41:57.993294Z","steps":["trace[1750400631] 'process raft request' (duration: 408.819938ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:57.993453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:57.584156Z","time spent":"409.203879ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T14:41:57.9933Z","caller":"traceutil/trace.go:171","msg":"trace[513065862] transaction","detail":"{read_only:false; response_revision:25790; number_of_response:1; }","duration":"286.023635ms","start":"2026-05-28T14:41:57.707265Z","end":"2026-05-28T14:41:57.993288Z","steps":["trace[513065862] 'process raft request' (duration: 285.87375ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:57.993527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:57.584232Z","time spent":"409.206519ms","remote":"127.0.0.1:49928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":921,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T14:41:57.993543Z","caller":"traceutil/trace.go:171","msg":"trace[2031559064] transaction","detail":"{read_only:false; response_revision:25787; number_of_response:1; }","duration":"414.959097ms","start":"2026-05-28T14:41:57.578561Z","end":"2026-05-28T14:41:57.99352Z","steps":["trace[2031559064] 'process raft request' (duration: 414.226797ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:57.993741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:57.578552Z","time spent":"415.110482ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T14:41:57.993586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.958137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/openstack/container-infra\" ","response":"range_response_count:1 size:726"} {"level":"info","ts":"2026-05-28T14:41:57.993864Z","caller":"traceutil/trace.go:171","msg":"trace[964708816] range","detail":"{range_begin:/registry/ingress/openstack/container-infra; range_end:; response_count:1; response_revision:25790; }","duration":"415.242555ms","start":"2026-05-28T14:41:57.578595Z","end":"2026-05-28T14:41:57.993838Z","steps":["trace[964708816] 'agreement among raft nodes before linearized reading' (duration: 414.817643ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:57.993931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:57.578591Z","time spent":"415.324538ms","remote":"127.0.0.1:49928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":750,"request content":"key:\"/registry/ingress/openstack/container-infra\" "} {"level":"info","ts":"2026-05-28T14:41:58.291998Z","caller":"traceutil/trace.go:171","msg":"trace[928774015] transaction","detail":"{read_only:false; response_revision:25791; number_of_response:1; }","duration":"366.055005ms","start":"2026-05-28T14:41:57.925913Z","end":"2026-05-28T14:41:58.291968Z","steps":["trace[928774015] 'process raft request' (duration: 279.635647ms)","trace[928774015] 'compare' (duration: 86.278474ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:41:58.292153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:57.925887Z","time spent":"366.186339ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T14:41:58.294117Z","caller":"traceutil/trace.go:171","msg":"trace[1449188136] transaction","detail":"{read_only:false; response_revision:25792; number_of_response:1; }","duration":"308.504875ms","start":"2026-05-28T14:41:57.98559Z","end":"2026-05-28T14:41:58.294095Z","steps":["trace[1449188136] 'process raft request' (duration: 308.342431ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:41:58.294433Z","caller":"traceutil/trace.go:171","msg":"trace[1465245622] transaction","detail":"{read_only:false; response_revision:25793; number_of_response:1; }","duration":"307.282822ms","start":"2026-05-28T14:41:57.987127Z","end":"2026-05-28T14:41:58.29441Z","steps":["trace[1465245622] 'process raft request' (duration: 306.918512ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:58.294571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:57.987097Z","time spent":"307.388855ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T14:41:58.294529Z","caller":"traceutil/trace.go:171","msg":"trace[552444072] linearizableReadLoop","detail":"{readStateIndex:26651; appliedIndex:26648; }","duration":"301.245804ms","start":"2026-05-28T14:41:57.99326Z","end":"2026-05-28T14:41:58.294505Z","steps":["trace[552444072] 'read index received' (duration: 212.302626ms)","trace[552444072] 'applied index is now lower than readState.Index' (duration: 88.939918ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:41:58.294563Z","caller":"traceutil/trace.go:171","msg":"trace[658583445] transaction","detail":"{read_only:false; response_revision:25795; number_of_response:1; }","duration":"135.445913ms","start":"2026-05-28T14:41:58.159088Z","end":"2026-05-28T14:41:58.294534Z","steps":["trace[658583445] 'process raft request' (duration: 135.34988ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:41:58.294598Z","caller":"traceutil/trace.go:171","msg":"trace[1483329334] transaction","detail":"{read_only:false; response_revision:25794; number_of_response:1; }","duration":"297.211973ms","start":"2026-05-28T14:41:57.997362Z","end":"2026-05-28T14:41:58.294574Z","steps":["trace[1483329334] 'process raft request' (duration: 296.929235ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:58.294734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.913978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:41:58.294798Z","caller":"traceutil/trace.go:171","msg":"trace[1934517610] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25795; }","duration":"595.9839ms","start":"2026-05-28T14:41:57.698797Z","end":"2026-05-28T14:41:58.29478Z","steps":["trace[1934517610] 'agreement among raft nodes before linearized reading' (duration: 595.871577ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:58.294807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.758567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"warn","ts":"2026-05-28T14:41:58.29484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:57.698779Z","time spent":"596.051421ms","remote":"127.0.0.1:38390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":30,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "} {"level":"warn","ts":"2026-05-28T14:41:58.294822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.610348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18623"} {"level":"info","ts":"2026-05-28T14:41:58.294856Z","caller":"traceutil/trace.go:171","msg":"trace[50465536] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25795; }","duration":"416.85192ms","start":"2026-05-28T14:41:57.877991Z","end":"2026-05-28T14:41:58.294843Z","steps":["trace[50465536] 'agreement among raft nodes before linearized reading' (duration: 416.639194ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:58.294895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:57.877976Z","time spent":"416.910481ms","remote":"127.0.0.1:49724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":381,"request content":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" "} {"level":"info","ts":"2026-05-28T14:41:58.294893Z","caller":"traceutil/trace.go:171","msg":"trace[1864985470] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25795; }","duration":"710.70492ms","start":"2026-05-28T14:41:57.584173Z","end":"2026-05-28T14:41:58.294878Z","steps":["trace[1864985470] 'agreement among raft nodes before linearized reading' (duration: 710.516204ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:58.294904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.420677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/container-infra-registry.18b3c1be63ed5c01\" ","response":"range_response_count:1 size:722"} {"level":"warn","ts":"2026-05-28T14:41:58.294946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:57.584159Z","time spent":"710.774932ms","remote":"127.0.0.1:49794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":18647,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-28T14:41:58.294944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.792211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:41:58.294951Z","caller":"traceutil/trace.go:171","msg":"trace[541345699] range","detail":"{range_begin:/registry/events/openstack/container-infra-registry.18b3c1be63ed5c01; range_end:; response_count:1; response_revision:25795; }","duration":"298.515259ms","start":"2026-05-28T14:41:57.99642Z","end":"2026-05-28T14:41:58.294935Z","steps":["trace[541345699] 'agreement among raft nodes before linearized reading' (duration: 298.323634ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:41:58.295012Z","caller":"traceutil/trace.go:171","msg":"trace[397747462] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25795; }","duration":"199.888514ms","start":"2026-05-28T14:41:58.095108Z","end":"2026-05-28T14:41:58.294997Z","steps":["trace[397747462] 'agreement among raft nodes before linearized reading' (duration: 199.792931ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:58.294913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.306779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machines/\" range_end:\"/registry/cluster.x-k8s.io/machines0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-28T14:41:58.294956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.950375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-nb-0\" ","response":"range_response_count:1 size:1566"} {"level":"info","ts":"2026-05-28T14:41:58.295077Z","caller":"traceutil/trace.go:171","msg":"trace[1799683365] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machines/; range_end:/registry/cluster.x-k8s.io/machines0; response_count:0; response_revision:25795; }","duration":"186.511285ms","start":"2026-05-28T14:41:58.108544Z","end":"2026-05-28T14:41:58.295055Z","steps":["trace[1799683365] 'agreement among raft nodes before linearized reading' (duration: 186.309289ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:41:58.295156Z","caller":"traceutil/trace.go:171","msg":"trace[192514857] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-nb-0; range_end:; response_count:1; response_revision:25795; }","duration":"496.207233ms","start":"2026-05-28T14:41:57.7989Z","end":"2026-05-28T14:41:58.295107Z","steps":["trace[192514857] 'agreement among raft nodes before linearized reading' (duration: 495.671568ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:58.29545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:57.798883Z","time spent":"496.553822ms","remote":"127.0.0.1:49790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":1590,"request content":"key:\"/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-nb-0\" "} {"level":"warn","ts":"2026-05-28T14:41:58.295339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:57.985568Z","time spent":"308.620019ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T14:41:58.529279Z","caller":"traceutil/trace.go:171","msg":"trace[97129116] linearizableReadLoop","detail":"{readStateIndex:26654; appliedIndex:26653; }","duration":"230.171611ms","start":"2026-05-28T14:41:58.299083Z","end":"2026-05-28T14:41:58.529254Z","steps":["trace[97129116] 'read index received' (duration: 159.984111ms)","trace[97129116] 'applied index is now lower than readState.Index' (duration: 70.18652ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:41:58.529518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.418747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-b1e1e1e9-1020-42c3-9985-a613d981e971\" ","response":"range_response_count:1 size:1284"} {"level":"info","ts":"2026-05-28T14:41:58.529514Z","caller":"traceutil/trace.go:171","msg":"trace[667916330] transaction","detail":"{read_only:false; response_revision:25796; number_of_response:1; }","duration":"231.415155ms","start":"2026-05-28T14:41:58.298079Z","end":"2026-05-28T14:41:58.529494Z","steps":["trace[667916330] 'process raft request' (duration: 161.060441ms)","trace[667916330] 'compare' (duration: 69.988044ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:41:58.529567Z","caller":"traceutil/trace.go:171","msg":"trace[1583164520] range","detail":"{range_begin:/registry/persistentvolumes/pvc-b1e1e1e9-1020-42c3-9985-a613d981e971; range_end:; response_count:1; response_revision:25796; }","duration":"230.489699ms","start":"2026-05-28T14:41:58.299067Z","end":"2026-05-28T14:41:58.529557Z","steps":["trace[1583164520] 'agreement among raft nodes before linearized reading' (duration: 230.339125ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:58.529562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.625241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:41:58.529623Z","caller":"traceutil/trace.go:171","msg":"trace[810345780] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25796; }","duration":"227.700372ms","start":"2026-05-28T14:41:58.301904Z","end":"2026-05-28T14:41:58.529604Z","steps":["trace[810345780] 'agreement among raft nodes before linearized reading' (duration: 227.60186ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:58.529638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.655248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"} {"level":"info","ts":"2026-05-28T14:41:58.529676Z","caller":"traceutil/trace.go:171","msg":"trace[1900778824] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:25796; }","duration":"224.71481ms","start":"2026-05-28T14:41:58.304951Z","end":"2026-05-28T14:41:58.529665Z","steps":["trace[1900778824] 'agreement among raft nodes before linearized reading' (duration: 224.580956ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:41:59.144535Z","caller":"traceutil/trace.go:171","msg":"trace[1028472628] transaction","detail":"{read_only:false; response_revision:25800; number_of_response:1; }","duration":"175.156851ms","start":"2026-05-28T14:41:58.969351Z","end":"2026-05-28T14:41:59.144507Z","steps":["trace[1028472628] 'process raft request' (duration: 174.995586ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:59.464994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.839213ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-28T14:41:59.465282Z","caller":"traceutil/trace.go:171","msg":"trace[529335165] transaction","detail":"{read_only:false; response_revision:25803; number_of_response:1; }","duration":"145.46562ms","start":"2026-05-28T14:41:59.319792Z","end":"2026-05-28T14:41:59.465258Z","steps":["trace[529335165] 'process raft request' (duration: 145.404078ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:41:59.465325Z","caller":"traceutil/trace.go:171","msg":"trace[1754689104] transaction","detail":"{read_only:false; response_revision:25802; number_of_response:1; }","duration":"473.019862ms","start":"2026-05-28T14:41:58.992286Z","end":"2026-05-28T14:41:59.465306Z","steps":["trace[1754689104] 'process raft request' (duration: 472.820166ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:41:59.465339Z","caller":"traceutil/trace.go:171","msg":"trace[555786777] transaction","detail":"{read_only:false; response_revision:25801; number_of_response:1; }","duration":"494.854225ms","start":"2026-05-28T14:41:58.970451Z","end":"2026-05-28T14:41:59.465305Z","steps":["trace[555786777] 'process raft request' (duration: 273.607371ms)","trace[555786777] 'compare' (duration: 220.571285ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:41:59.465357Z","caller":"traceutil/trace.go:171","msg":"trace[1508409747] linearizableReadLoop","detail":"{readStateIndex:26660; appliedIndex:26658; }","duration":"407.600724ms","start":"2026-05-28T14:41:59.057719Z","end":"2026-05-28T14:41:59.465319Z","steps":["trace[1508409747] 'read index received' (duration: 86.969814ms)","trace[1508409747] 'applied index is now lower than readState.Index' (duration: 320.62662ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:41:59.465413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:58.992262Z","time spent":"473.103784ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T14:41:59.465474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:58.97042Z","time spent":"494.993209ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T14:41:59.465598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.82099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedeployments/\" range_end:\"/registry/cluster.x-k8s.io/machinedeployments0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:41:59.465678Z","caller":"traceutil/trace.go:171","msg":"trace[652494091] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedeployments/; range_end:/registry/cluster.x-k8s.io/machinedeployments0; response_count:0; response_revision:25803; }","duration":"407.993965ms","start":"2026-05-28T14:41:59.057665Z","end":"2026-05-28T14:41:59.465658Z","steps":["trace[652494091] 'agreement among raft nodes before linearized reading' (duration: 407.769618ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:41:59.465735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:41:59.057637Z","time spent":"408.080137ms","remote":"127.0.0.1:38158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":30,"request content":"key:\"/registry/cluster.x-k8s.io/machinedeployments/\" range_end:\"/registry/cluster.x-k8s.io/machinedeployments0\" count_only:true "} {"level":"warn","ts":"2026-05-28T14:41:59.732477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.172681ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-28T14:41:59.732599Z","caller":"traceutil/trace.go:171","msg":"trace[208281033] transaction","detail":"{read_only:false; response_revision:25804; number_of_response:1; }","duration":"156.557506ms","start":"2026-05-28T14:41:59.576021Z","end":"2026-05-28T14:41:59.732579Z","steps":["trace[208281033] 'process raft request' (duration: 36.187109ms)","trace[208281033] 'compare' (duration: 119.632907ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:00.202368Z","caller":"traceutil/trace.go:171","msg":"trace[795656718] transaction","detail":"{read_only:false; response_revision:25806; number_of_response:1; }","duration":"203.237596ms","start":"2026-05-28T14:41:59.999091Z","end":"2026-05-28T14:42:00.202328Z","steps":["trace[795656718] 'process raft request' (duration: 203.069131ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:00.202582Z","caller":"traceutil/trace.go:171","msg":"trace[1191007758] linearizableReadLoop","detail":"{readStateIndex:26664; appliedIndex:26664; }","duration":"165.395271ms","start":"2026-05-28T14:42:00.037148Z","end":"2026-05-28T14:42:00.202543Z","steps":["trace[1191007758] 'read index received' (duration: 165.380641ms)","trace[1191007758] 'applied index is now lower than readState.Index' (duration: 12.01µs)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:42:00.202875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.694159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-28T14:42:00.202941Z","caller":"traceutil/trace.go:171","msg":"trace[213334524] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:25806; }","duration":"165.833222ms","start":"2026-05-28T14:42:00.037091Z","end":"2026-05-28T14:42:00.202924Z","steps":["trace[213334524] 'agreement among raft nodes before linearized reading' (duration: 165.657388ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:00.342085Z","caller":"traceutil/trace.go:171","msg":"trace[977225338] transaction","detail":"{read_only:false; response_revision:25807; number_of_response:1; }","duration":"256.617391ms","start":"2026-05-28T14:42:00.085449Z","end":"2026-05-28T14:42:00.342066Z","steps":["trace[977225338] 'process raft request' (duration: 243.285663ms)","trace[977225338] 'compare' (duration: 13.074481ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:00.342357Z","caller":"traceutil/trace.go:171","msg":"trace[1270704018] transaction","detail":"{read_only:false; response_revision:25808; number_of_response:1; }","duration":"256.480987ms","start":"2026-05-28T14:42:00.085867Z","end":"2026-05-28T14:42:00.342348Z","steps":["trace[1270704018] 'process raft request' (duration: 256.125037ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:00.342697Z","caller":"traceutil/trace.go:171","msg":"trace[952497453] transaction","detail":"{read_only:false; response_revision:25809; number_of_response:1; }","duration":"193.438575ms","start":"2026-05-28T14:42:00.149226Z","end":"2026-05-28T14:42:00.342665Z","steps":["trace[952497453] 'process raft request' (duration: 193.219039ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:00.3427Z","caller":"traceutil/trace.go:171","msg":"trace[396687689] linearizableReadLoop","detail":"{readStateIndex:26667; appliedIndex:26664; }","duration":"139.933707ms","start":"2026-05-28T14:42:00.202709Z","end":"2026-05-28T14:42:00.342642Z","steps":["trace[396687689] 'read index received' (duration: 126.133566ms)","trace[396687689] 'applied index is now lower than readState.Index' (duration: 13.799051ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:42:00.3428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.437303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-28T14:42:00.343037Z","caller":"traceutil/trace.go:171","msg":"trace[1708991930] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:25809; }","duration":"190.725201ms","start":"2026-05-28T14:42:00.152285Z","end":"2026-05-28T14:42:00.343011Z","steps":["trace[1708991930] 'agreement among raft nodes before linearized reading' (duration: 190.410042ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:00.343944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.877525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:42:00.344034Z","caller":"traceutil/trace.go:171","msg":"trace[2044870762] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25809; }","duration":"250.002068ms","start":"2026-05-28T14:42:00.094018Z","end":"2026-05-28T14:42:00.34402Z","steps":["trace[2044870762] 'agreement among raft nodes before linearized reading' (duration: 248.762584ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:00.549043Z","caller":"traceutil/trace.go:171","msg":"trace[1744664620] linearizableReadLoop","detail":"{readStateIndex:26669; appliedIndex:26667; }","duration":"203.580036ms","start":"2026-05-28T14:42:00.345432Z","end":"2026-05-28T14:42:00.549012Z","steps":["trace[1744664620] 'read index received' (duration: 153.149223ms)","trace[1744664620] 'applied index is now lower than readState.Index' (duration: 50.429643ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:42:00.549206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.757631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:42:00.549259Z","caller":"traceutil/trace.go:171","msg":"trace[1957282926] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25811; }","duration":"203.865684ms","start":"2026-05-28T14:42:00.345381Z","end":"2026-05-28T14:42:00.549247Z","steps":["trace[1957282926] 'agreement among raft nodes before linearized reading' (duration: 203.74252ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:00.549196Z","caller":"traceutil/trace.go:171","msg":"trace[2037278024] transaction","detail":"{read_only:false; response_revision:25810; number_of_response:1; }","duration":"247.677845ms","start":"2026-05-28T14:42:00.301485Z","end":"2026-05-28T14:42:00.549163Z","steps":["trace[2037278024] 'process raft request' (duration: 197.168579ms)","trace[2037278024] 'compare' (duration: 49.95071ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:00.549531Z","caller":"traceutil/trace.go:171","msg":"trace[1490473528] transaction","detail":"{read_only:false; response_revision:25811; number_of_response:1; }","duration":"244.783195ms","start":"2026-05-28T14:42:00.304705Z","end":"2026-05-28T14:42:00.549488Z","steps":["trace[1490473528] 'process raft request' (duration: 244.230669ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:01.800865Z","caller":"traceutil/trace.go:171","msg":"trace[1332975076] linearizableReadLoop","detail":"{readStateIndex:26675; appliedIndex:26674; }","duration":"327.434999ms","start":"2026-05-28T14:42:01.473396Z","end":"2026-05-28T14:42:01.800831Z","steps":["trace[1332975076] 'read index received' (duration: 23.51758ms)","trace[1332975076] 'applied index is now lower than readState.Index' (duration: 303.916059ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:42:01.801126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.708216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-05-28T14:42:01.80117Z","caller":"traceutil/trace.go:171","msg":"trace[1382353512] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25817; }","duration":"327.768908ms","start":"2026-05-28T14:42:01.47339Z","end":"2026-05-28T14:42:01.801159Z","steps":["trace[1382353512] 'agreement among raft nodes before linearized reading' (duration: 327.550242ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:01.801204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:42:01.473361Z","time spent":"327.83498ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-28T14:42:01.801265Z","caller":"traceutil/trace.go:171","msg":"trace[1056179399] transaction","detail":"{read_only:false; response_revision:25817; number_of_response:1; }","duration":"330.155304ms","start":"2026-05-28T14:42:01.471083Z","end":"2026-05-28T14:42:01.801238Z","steps":["trace[1056179399] 'process raft request' (duration: 308.608529ms)","trace[1056179399] 'compare' (duration: 20.716212ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:42:01.801418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:42:01.471053Z","time spent":"330.285857ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T14:42:01.973132Z","caller":"traceutil/trace.go:171","msg":"trace[1239759340] transaction","detail":"{read_only:false; response_revision:25818; number_of_response:1; }","duration":"235.059295ms","start":"2026-05-28T14:42:01.738045Z","end":"2026-05-28T14:42:01.973104Z","steps":["trace[1239759340] 'process raft request' (duration: 234.613393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:02.161014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.838351ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-28T14:42:02.161174Z","caller":"traceutil/trace.go:171","msg":"trace[1959822889] transaction","detail":"{read_only:false; response_revision:25819; number_of_response:1; }","duration":"355.71024ms","start":"2026-05-28T14:42:01.805437Z","end":"2026-05-28T14:42:02.161148Z","steps":["trace[1959822889] 'process raft request' (duration: 167.650263ms)","trace[1959822889] 'compare' (duration: 187.729938ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:02.16118Z","caller":"traceutil/trace.go:171","msg":"trace[1617912015] linearizableReadLoop","detail":"{readStateIndex:26678; appliedIndex:26675; }","duration":"283.274019ms","start":"2026-05-28T14:42:01.87783Z","end":"2026-05-28T14:42:02.161104Z","steps":["trace[1617912015] 'read index received' (duration: 21.468354ms)","trace[1617912015] 'applied index is now lower than readState.Index' (duration: 261.804485ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:42:02.161269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:42:01.805425Z","time spent":"355.800552ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T14:42:02.161392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.306801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-28T14:42:02.161535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.68389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-28T14:42:02.161638Z","caller":"traceutil/trace.go:171","msg":"trace[1218230861] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25819; }","duration":"283.821304ms","start":"2026-05-28T14:42:01.877793Z","end":"2026-05-28T14:42:02.161614Z","steps":["trace[1218230861] 'agreement among raft nodes before linearized reading' (duration: 283.460784ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:02.162505Z","caller":"traceutil/trace.go:171","msg":"trace[597014661] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:25819; }","duration":"223.424484ms","start":"2026-05-28T14:42:01.938031Z","end":"2026-05-28T14:42:02.161456Z","steps":["trace[597014661] 'agreement among raft nodes before linearized reading' (duration: 223.284571ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:02.409257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.976134ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-28T14:42:02.40944Z","caller":"traceutil/trace.go:171","msg":"trace[577197018] transaction","detail":"{read_only:false; response_revision:25820; number_of_response:1; }","duration":"244.571978ms","start":"2026-05-28T14:42:02.164846Z","end":"2026-05-28T14:42:02.409418Z","steps":["trace[577197018] 'process raft request' (duration: 107.337556ms)","trace[577197018] 'compare' (duration: 136.766649ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:02.409501Z","caller":"traceutil/trace.go:171","msg":"trace[951427054] linearizableReadLoop","detail":"{readStateIndex:26680; appliedIndex:26678; }","duration":"123.136102ms","start":"2026-05-28T14:42:02.286345Z","end":"2026-05-28T14:42:02.409481Z","steps":["trace[951427054] 'read index received' (duration: 118.543396ms)","trace[951427054] 'applied index is now lower than readState.Index' (duration: 4.591696ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:42:02.40977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.41848ms","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:8"} {"level":"info","ts":"2026-05-28T14:42:02.409801Z","caller":"traceutil/trace.go:171","msg":"trace[349251817] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:25821; }","duration":"123.461211ms","start":"2026-05-28T14:42:02.28633Z","end":"2026-05-28T14:42:02.409791Z","steps":["trace[349251817] 'agreement among raft nodes before linearized reading' (duration: 123.328977ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:02.40989Z","caller":"traceutil/trace.go:171","msg":"trace[1607895187] transaction","detail":"{read_only:false; response_revision:25821; number_of_response:1; }","duration":"201.959241ms","start":"2026-05-28T14:42:02.207924Z","end":"2026-05-28T14:42:02.409884Z","steps":["trace[1607895187] 'process raft request' (duration: 201.446596ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:02.58041Z","caller":"traceutil/trace.go:171","msg":"trace[1820088642] transaction","detail":"{read_only:false; response_revision:25822; number_of_response:1; }","duration":"166.613634ms","start":"2026-05-28T14:42:02.413772Z","end":"2026-05-28T14:42:02.580385Z","steps":["trace[1820088642] 'process raft request' (duration: 166.47233ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:02.581112Z","caller":"traceutil/trace.go:171","msg":"trace[1305949860] transaction","detail":"{read_only:false; response_revision:25823; number_of_response:1; }","duration":"165.278448ms","start":"2026-05-28T14:42:02.415822Z","end":"2026-05-28T14:42:02.5811Z","steps":["trace[1305949860] 'process raft request' (duration: 165.024941ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:02.908969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.541668ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-28T14:42:02.909042Z","caller":"traceutil/trace.go:171","msg":"trace[903725561] transaction","detail":"{read_only:false; response_revision:25826; number_of_response:1; }","duration":"201.496778ms","start":"2026-05-28T14:42:02.707533Z","end":"2026-05-28T14:42:02.90903Z","steps":["trace[903725561] 'process raft request' (duration: 49.706953ms)","trace[903725561] 'compare' (duration: 151.361913ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:02.921706Z","caller":"traceutil/trace.go:171","msg":"trace[1405089198] transaction","detail":"{read_only:false; response_revision:25827; number_of_response:1; }","duration":"213.662675ms","start":"2026-05-28T14:42:02.708012Z","end":"2026-05-28T14:42:02.921675Z","steps":["trace[1405089198] 'process raft request' (duration: 213.51311ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:03.33378Z","caller":"traceutil/trace.go:171","msg":"trace[1332276017] transaction","detail":"{read_only:false; response_revision:25828; number_of_response:1; }","duration":"116.798328ms","start":"2026-05-28T14:42:03.216954Z","end":"2026-05-28T14:42:03.333752Z","steps":["trace[1332276017] 'process raft request' (duration: 116.609383ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:03.647014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.011847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:42:03.647106Z","caller":"traceutil/trace.go:171","msg":"trace[1912267800] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:25828; }","duration":"145.161602ms","start":"2026-05-28T14:42:03.501924Z","end":"2026-05-28T14:42:03.647086Z","steps":["trace[1912267800] 'count revisions from in-memory index tree' (duration: 144.873083ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:03.647376Z","caller":"traceutil/trace.go:171","msg":"trace[1516253451] linearizableReadLoop","detail":"{readStateIndex:26688; appliedIndex:26687; }","duration":"111.203703ms","start":"2026-05-28T14:42:03.536133Z","end":"2026-05-28T14:42:03.647337Z","steps":["trace[1516253451] 'read index received' (duration: 102.201004ms)","trace[1516253451] 'applied index is now lower than readState.Index' (duration: 9.001029ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:03.647453Z","caller":"traceutil/trace.go:171","msg":"trace[994901716] transaction","detail":"{read_only:false; response_revision:25829; number_of_response:1; }","duration":"145.079089ms","start":"2026-05-28T14:42:03.502327Z","end":"2026-05-28T14:42:03.647407Z","steps":["trace[994901716] 'process raft request' (duration: 135.998998ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:03.647725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.560812ms","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-28T14:42:03.647771Z","caller":"traceutil/trace.go:171","msg":"trace[1542291403] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25829; }","duration":"111.667036ms","start":"2026-05-28T14:42:03.536091Z","end":"2026-05-28T14:42:03.647758Z","steps":["trace[1542291403] 'agreement among raft nodes before linearized reading' (duration: 111.416969ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:07.219408Z","caller":"traceutil/trace.go:171","msg":"trace[1186750959] transaction","detail":"{read_only:false; response_revision:25847; number_of_response:1; }","duration":"797.629362ms","start":"2026-05-28T14:42:06.421728Z","end":"2026-05-28T14:42:07.219357Z","steps":["trace[1186750959] 'process raft request' (duration: 748.665039ms)","trace[1186750959] 'compare' (duration: 48.662495ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:07.219487Z","caller":"traceutil/trace.go:171","msg":"trace[1865929110] transaction","detail":"{read_only:false; response_revision:25852; number_of_response:1; }","duration":"285.428537ms","start":"2026-05-28T14:42:06.934035Z","end":"2026-05-28T14:42:07.219463Z","steps":["trace[1865929110] 'process raft request' (duration: 285.352975ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:07.219533Z","caller":"traceutil/trace.go:171","msg":"trace[1924363814] transaction","detail":"{read_only:false; response_revision:25849; number_of_response:1; }","duration":"625.020982ms","start":"2026-05-28T14:42:06.594481Z","end":"2026-05-28T14:42:07.219502Z","steps":["trace[1924363814] 'process raft request' (duration: 624.761665ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:07.21954Z","caller":"traceutil/trace.go:171","msg":"trace[1267253758] transaction","detail":"{read_only:false; response_revision:25848; number_of_response:1; }","duration":"626.75218ms","start":"2026-05-28T14:42:06.592747Z","end":"2026-05-28T14:42:07.219499Z","steps":["trace[1267253758] 'process raft request' (duration: 626.448782ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:07.219589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:42:06.421708Z","time spent":"797.793806ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T14:42:07.219615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:42:06.594466Z","time spent":"625.108764ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T14:42:07.219502Z","caller":"traceutil/trace.go:171","msg":"trace[897086783] linearizableReadLoop","detail":"{readStateIndex:26707; appliedIndex:26705; }","duration":"794.417184ms","start":"2026-05-28T14:42:06.425057Z","end":"2026-05-28T14:42:07.219474Z","steps":["trace[897086783] 'read index received' (duration: 172.978891ms)","trace[897086783] 'applied index is now lower than readState.Index' (duration: 621.435213ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:07.219639Z","caller":"traceutil/trace.go:171","msg":"trace[818486676] transaction","detail":"{read_only:false; response_revision:25850; number_of_response:1; }","duration":"620.630491ms","start":"2026-05-28T14:42:06.598941Z","end":"2026-05-28T14:42:07.219571Z","steps":["trace[818486676] 'process raft request' (duration: 620.349404ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:07.219704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.640449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-28T14:42:07.219715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:42:06.592723Z","time spent":"626.907864ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T14:42:07.21976Z","caller":"traceutil/trace.go:171","msg":"trace[1347344221] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25852; }","duration":"794.731332ms","start":"2026-05-28T14:42:06.425013Z","end":"2026-05-28T14:42:07.219745Z","steps":["trace[1347344221] 'agreement among raft nodes before linearized reading' (duration: 794.556147ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:07.219759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.973792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-28T14:42:07.219801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:42:06.425Z","time spent":"794.793404ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-28T14:42:07.219806Z","caller":"traceutil/trace.go:171","msg":"trace[1413237965] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:25852; }","duration":"781.064744ms","start":"2026-05-28T14:42:06.438728Z","end":"2026-05-28T14:42:07.219793Z","steps":["trace[1413237965] 'agreement among raft nodes before linearized reading' (duration: 780.984652ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:07.219821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.827201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-05-28T14:42:07.219781Z","caller":"traceutil/trace.go:171","msg":"trace[2077805634] transaction","detail":"{read_only:false; response_revision:25851; number_of_response:1; }","duration":"298.847609ms","start":"2026-05-28T14:42:06.920732Z","end":"2026-05-28T14:42:07.219579Z","steps":["trace[2077805634] 'process raft request' (duration: 298.621102ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:07.219838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:42:06.438708Z","time spent":"781.123866ms","remote":"127.0.0.1:43718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true "} {"level":"info","ts":"2026-05-28T14:42:07.219854Z","caller":"traceutil/trace.go:171","msg":"trace[1778646203] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25852; }","duration":"622.901364ms","start":"2026-05-28T14:42:06.596944Z","end":"2026-05-28T14:42:07.219846Z","steps":["trace[1778646203] 'agreement among raft nodes before linearized reading' (duration: 622.782211ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:07.219876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:42:06.596922Z","time spent":"622.949515ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-28T14:42:07.21989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:42:06.598927Z","time spent":"620.837667ms","remote":"127.0.0.1:49664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":119,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T14:42:07.219923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.780246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:42:07.219951Z","caller":"traceutil/trace.go:171","msg":"trace[1424280316] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25852; }","duration":"125.847008ms","start":"2026-05-28T14:42:07.094096Z","end":"2026-05-28T14:42:07.219943Z","steps":["trace[1424280316] 'agreement among raft nodes before linearized reading' (duration: 125.804836ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:07.22006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.523969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-05-28T14:42:07.220103Z","caller":"traceutil/trace.go:171","msg":"trace[718310753] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25852; }","duration":"624.599331ms","start":"2026-05-28T14:42:06.595493Z","end":"2026-05-28T14:42:07.220092Z","steps":["trace[718310753] 'agreement among raft nodes before linearized reading' (duration: 624.251491ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:07.220131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:42:06.595481Z","time spent":"624.644142ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-28T14:42:16.697384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.536899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c2d4187f-e569-487e-890e-a9cc4c6ea50b\" ","response":"range_response_count:1 size:3643"} {"level":"info","ts":"2026-05-28T14:42:16.697476Z","caller":"traceutil/trace.go:171","msg":"trace[20384631] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c2d4187f-e569-487e-890e-a9cc4c6ea50b; range_end:; response_count:1; response_revision:25981; }","duration":"302.672663ms","start":"2026-05-28T14:42:16.394784Z","end":"2026-05-28T14:42:16.697457Z","steps":["trace[20384631] 'range keys from in-memory index tree' (duration: 302.361175ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:16.697521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:42:16.394767Z","time spent":"302.743875ms","remote":"127.0.0.1:49800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3667,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c2d4187f-e569-487e-890e-a9cc4c6ea50b\" "} {"level":"warn","ts":"2026-05-28T14:42:16.697504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.113568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c2d4187f-e569-487e-890e-a9cc4c6ea50b\" ","response":"range_response_count:1 size:3643"} {"level":"info","ts":"2026-05-28T14:42:16.697631Z","caller":"traceutil/trace.go:171","msg":"trace[1554315674] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c2d4187f-e569-487e-890e-a9cc4c6ea50b; range_end:; response_count:1; response_revision:25981; }","duration":"306.293743ms","start":"2026-05-28T14:42:16.391306Z","end":"2026-05-28T14:42:16.6976Z","steps":["trace[1554315674] 'range keys from in-memory index tree' (duration: 305.893452ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:16.697689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:42:16.391294Z","time spent":"306.382476ms","remote":"127.0.0.1:49800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3667,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c2d4187f-e569-487e-890e-a9cc4c6ea50b\" "} {"level":"info","ts":"2026-05-28T14:42:16.907031Z","caller":"traceutil/trace.go:171","msg":"trace[357767182] transaction","detail":"{read_only:false; response_revision:25982; number_of_response:1; }","duration":"201.293073ms","start":"2026-05-28T14:42:16.70571Z","end":"2026-05-28T14:42:16.907003Z","steps":["trace[357767182] 'process raft request' (duration: 201.109637ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:17.252912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.04549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:42:17.253015Z","caller":"traceutil/trace.go:171","msg":"trace[422176529] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25982; }","duration":"157.210104ms","start":"2026-05-28T14:42:17.095782Z","end":"2026-05-28T14:42:17.252992Z","steps":["trace[422176529] 'range keys from in-memory index tree' (duration: 156.957827ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:17.505896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.237681ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-28T14:42:17.506187Z","caller":"traceutil/trace.go:171","msg":"trace[1956461397] transaction","detail":"{read_only:false; response_revision:25984; number_of_response:1; }","duration":"244.25777ms","start":"2026-05-28T14:42:17.261892Z","end":"2026-05-28T14:42:17.506149Z","steps":["trace[1956461397] 'process raft request' (duration: 114.675149ms)","trace[1956461397] 'compare' (duration: 129.062746ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:17.506254Z","caller":"traceutil/trace.go:171","msg":"trace[1987467920] linearizableReadLoop","detail":"{readStateIndex:26850; appliedIndex:26845; }","duration":"238.875911ms","start":"2026-05-28T14:42:17.267359Z","end":"2026-05-28T14:42:17.506235Z","steps":["trace[1987467920] 'read index received' (duration: 68.168914ms)","trace[1987467920] 'applied index is now lower than readState.Index' (duration: 170.705747ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:17.506254Z","caller":"traceutil/trace.go:171","msg":"trace[616728079] transaction","detail":"{read_only:false; response_revision:25985; number_of_response:1; }","duration":"244.114306ms","start":"2026-05-28T14:42:17.262122Z","end":"2026-05-28T14:42:17.506236Z","steps":["trace[616728079] 'process raft request' (duration: 243.88597ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:17.506361Z","caller":"traceutil/trace.go:171","msg":"trace[690556726] transaction","detail":"{read_only:false; response_revision:25986; number_of_response:1; }","duration":"243.840368ms","start":"2026-05-28T14:42:17.262509Z","end":"2026-05-28T14:42:17.506349Z","steps":["trace[690556726] 'process raft request' (duration: 243.609272ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:17.506421Z","caller":"traceutil/trace.go:171","msg":"trace[1170723465] transaction","detail":"{read_only:false; response_revision:25987; number_of_response:1; }","duration":"243.614902ms","start":"2026-05-28T14:42:17.262798Z","end":"2026-05-28T14:42:17.506413Z","steps":["trace[1170723465] 'process raft request' (duration: 243.379305ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:17.506499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.66509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-28T14:42:17.506534Z","caller":"traceutil/trace.go:171","msg":"trace[1673462040] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25987; }","duration":"236.701891ms","start":"2026-05-28T14:42:17.269824Z","end":"2026-05-28T14:42:17.506526Z","steps":["trace[1673462040] 'agreement among raft nodes before linearized reading' (duration: 236.573117ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:17.506587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.20213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-28T14:42:17.506616Z","caller":"traceutil/trace.go:171","msg":"trace[372219326] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25987; }","duration":"239.266002ms","start":"2026-05-28T14:42:17.267343Z","end":"2026-05-28T14:42:17.506609Z","steps":["trace[372219326] 'agreement among raft nodes before linearized reading' (duration: 239.128538ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:17.506634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.546176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-05-28T14:42:17.506653Z","caller":"traceutil/trace.go:171","msg":"trace[1206306583] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25987; }","duration":"101.599597ms","start":"2026-05-28T14:42:17.405048Z","end":"2026-05-28T14:42:17.506647Z","steps":["trace[1206306583] 'agreement among raft nodes before linearized reading' (duration: 101.544226ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:17.506693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.594743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/servers/\" range_end:\"/registry/openstack.k-orc.cloud/servers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:42:17.506716Z","caller":"traceutil/trace.go:171","msg":"trace[1541601314] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/servers/; range_end:/registry/openstack.k-orc.cloud/servers0; response_count:0; response_revision:25987; }","duration":"145.648725ms","start":"2026-05-28T14:42:17.361058Z","end":"2026-05-28T14:42:17.506707Z","steps":["trace[1541601314] 'agreement among raft nodes before linearized reading' (duration: 145.611304ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:17.506745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.630735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-05-28T14:42:17.506767Z","caller":"traceutil/trace.go:171","msg":"trace[1565855260] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25987; }","duration":"225.671456ms","start":"2026-05-28T14:42:17.28109Z","end":"2026-05-28T14:42:17.506761Z","steps":["trace[1565855260] 'agreement among raft nodes before linearized reading' (duration: 225.610995ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:17.506757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.98079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"} {"level":"info","ts":"2026-05-28T14:42:17.506831Z","caller":"traceutil/trace.go:171","msg":"trace[619734233] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25987; }","duration":"190.090523ms","start":"2026-05-28T14:42:17.316724Z","end":"2026-05-28T14:42:17.506814Z","steps":["trace[619734233] 'agreement among raft nodes before linearized reading' (duration: 189.890647ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:17.756669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.025789ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-28T14:42:17.756855Z","caller":"traceutil/trace.go:171","msg":"trace[1815590661] transaction","detail":"{read_only:false; response_revision:25988; number_of_response:1; }","duration":"246.43835ms","start":"2026-05-28T14:42:17.51039Z","end":"2026-05-28T14:42:17.756829Z","steps":["trace[1815590661] 'process raft request' (duration: 110.131063ms)","trace[1815590661] 'compare' (duration: 135.889725ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:17.75939Z","caller":"traceutil/trace.go:171","msg":"trace[45540238] transaction","detail":"{read_only:false; response_revision:25989; number_of_response:1; }","duration":"248.538798ms","start":"2026-05-28T14:42:17.510817Z","end":"2026-05-28T14:42:17.759356Z","steps":["trace[45540238] 'process raft request' (duration: 248.358673ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:17.759676Z","caller":"traceutil/trace.go:171","msg":"trace[1613475002] transaction","detail":"{read_only:false; response_revision:25990; number_of_response:1; }","duration":"248.555729ms","start":"2026-05-28T14:42:17.511092Z","end":"2026-05-28T14:42:17.759648Z","steps":["trace[1613475002] 'process raft request' (duration: 248.2241ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:17.759807Z","caller":"traceutil/trace.go:171","msg":"trace[1346102753] linearizableReadLoop","detail":"{readStateIndex:26854; appliedIndex:26850; }","duration":"247.477599ms","start":"2026-05-28T14:42:17.512304Z","end":"2026-05-28T14:42:17.759781Z","steps":["trace[1346102753] 'read index received' (duration: 108.2199ms)","trace[1346102753] 'applied index is now lower than readState.Index' (duration: 139.256449ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:17.759883Z","caller":"traceutil/trace.go:171","msg":"trace[1868691933] transaction","detail":"{read_only:false; response_revision:25991; number_of_response:1; }","duration":"248.697673ms","start":"2026-05-28T14:42:17.511162Z","end":"2026-05-28T14:42:17.75986Z","steps":["trace[1868691933] 'process raft request' (duration: 248.511278ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:17.760056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.734397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" ","response":"range_response_count:1 size:1312"} {"level":"info","ts":"2026-05-28T14:42:17.760097Z","caller":"traceutil/trace.go:171","msg":"trace[115496026] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-manila-default-user; range_end:; response_count:1; response_revision:25991; }","duration":"247.809318ms","start":"2026-05-28T14:42:17.512277Z","end":"2026-05-28T14:42:17.760086Z","steps":["trace[115496026] 'agreement among raft nodes before linearized reading' (duration: 247.639683ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:18.125078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.285688ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:42:18.12526Z","caller":"traceutil/trace.go:171","msg":"trace[1266855123] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:25993; }","duration":"207.492253ms","start":"2026-05-28T14:42:17.917741Z","end":"2026-05-28T14:42:18.125233Z","steps":["trace[1266855123] 'range keys from in-memory index tree' (duration: 207.262297ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:18.125912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.617099ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-28T14:42:18.1262Z","caller":"traceutil/trace.go:171","msg":"trace[1680782858] transaction","detail":"{read_only:false; response_revision:25994; number_of_response:1; }","duration":"277.097197ms","start":"2026-05-28T14:42:17.849042Z","end":"2026-05-28T14:42:18.126139Z","steps":["trace[1680782858] 'process raft request' (duration: 129.1791ms)","trace[1680782858] 'compare' (duration: 147.193847ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:18.126215Z","caller":"traceutil/trace.go:171","msg":"trace[1727804531] linearizableReadLoop","detail":"{readStateIndex:26857; appliedIndex:26856; }","duration":"268.997844ms","start":"2026-05-28T14:42:17.857188Z","end":"2026-05-28T14:42:18.126186Z","steps":["trace[1727804531] 'read index received' (duration: 121.028285ms)","trace[1727804531] 'applied index is now lower than readState.Index' (duration: 147.966469ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:18.126216Z","caller":"traceutil/trace.go:171","msg":"trace[348001921] transaction","detail":"{read_only:false; response_revision:25995; number_of_response:1; }","duration":"264.989503ms","start":"2026-05-28T14:42:17.861209Z","end":"2026-05-28T14:42:18.126198Z","steps":["trace[348001921] 'process raft request' (duration: 264.894661ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:18.126512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.306022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9604"} {"level":"info","ts":"2026-05-28T14:42:18.126603Z","caller":"traceutil/trace.go:171","msg":"trace[191649138] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:25995; }","duration":"269.444626ms","start":"2026-05-28T14:42:17.857139Z","end":"2026-05-28T14:42:18.126583Z","steps":["trace[191649138] 'agreement among raft nodes before linearized reading' (duration: 269.145558ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:18.371117Z","caller":"traceutil/trace.go:171","msg":"trace[1221986990] linearizableReadLoop","detail":"{readStateIndex:26859; appliedIndex:26858; }","duration":"244.60881ms","start":"2026-05-28T14:42:18.126446Z","end":"2026-05-28T14:42:18.371055Z","steps":["trace[1221986990] 'read index received' (duration: 244.367503ms)","trace[1221986990] 'applied index is now lower than readState.Index' (duration: 239.777µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:18.371162Z","caller":"traceutil/trace.go:171","msg":"trace[954317632] transaction","detail":"{read_only:false; response_revision:25996; number_of_response:1; }","duration":"344.11467ms","start":"2026-05-28T14:42:18.02701Z","end":"2026-05-28T14:42:18.371124Z","steps":["trace[954317632] 'process raft request' (duration: 343.845292ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:18.371287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.82536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-28T14:42:18.37132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:42:18.026979Z","time spent":"344.251942ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T14:42:18.371354Z","caller":"traceutil/trace.go:171","msg":"trace[2026715701] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:25996; }","duration":"373.966354ms","start":"2026-05-28T14:42:17.997373Z","end":"2026-05-28T14:42:18.371339Z","steps":["trace[2026715701] 'agreement among raft nodes before linearized reading' (duration: 373.828871ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:18.371389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:42:17.997351Z","time spent":"374.030306ms","remote":"127.0.0.1:53094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-28T14:42:18.37141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.530031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"warn","ts":"2026-05-28T14:42:18.371411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.601469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-manila.18b3c1c65a4c166e\" ","response":"range_response_count:1 size:747"} {"level":"info","ts":"2026-05-28T14:42:18.37146Z","caller":"traceutil/trace.go:171","msg":"trace[616861231] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25996; }","duration":"120.647543ms","start":"2026-05-28T14:42:18.250796Z","end":"2026-05-28T14:42:18.371444Z","steps":["trace[616861231] 'agreement among raft nodes before linearized reading' (duration: 120.470608ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:18.371471Z","caller":"traceutil/trace.go:171","msg":"trace[287031353] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-manila.18b3c1c65a4c166e; range_end:; response_count:1; response_revision:25996; }","duration":"240.702942ms","start":"2026-05-28T14:42:18.130753Z","end":"2026-05-28T14:42:18.371456Z","steps":["trace[287031353] 'agreement among raft nodes before linearized reading' (duration: 240.516267ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:24.562581Z","caller":"traceutil/trace.go:171","msg":"trace[63023243] linearizableReadLoop","detail":"{readStateIndex:26927; appliedIndex:26926; }","duration":"159.567529ms","start":"2026-05-28T14:42:24.40299Z","end":"2026-05-28T14:42:24.562558Z","steps":["trace[63023243] 'read index received' (duration: 119.992585ms)","trace[63023243] 'applied index is now lower than readState.Index' (duration: 39.573844ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:24.562632Z","caller":"traceutil/trace.go:171","msg":"trace[66315982] transaction","detail":"{read_only:false; response_revision:26063; number_of_response:1; }","duration":"167.802617ms","start":"2026-05-28T14:42:24.394793Z","end":"2026-05-28T14:42:24.562595Z","steps":["trace[66315982] 'process raft request' (duration: 128.148351ms)","trace[66315982] 'compare' (duration: 39.518463ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:42:24.562768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.785016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-05-28T14:42:24.562805Z","caller":"traceutil/trace.go:171","msg":"trace[1904080598] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26063; }","duration":"159.860288ms","start":"2026-05-28T14:42:24.402932Z","end":"2026-05-28T14:42:24.562792Z","steps":["trace[1904080598] 'agreement among raft nodes before linearized reading' (duration: 159.714684ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:24.881312Z","caller":"traceutil/trace.go:171","msg":"trace[1220167518] transaction","detail":"{read_only:false; response_revision:26064; number_of_response:1; }","duration":"313.278597ms","start":"2026-05-28T14:42:24.568007Z","end":"2026-05-28T14:42:24.881285Z","steps":["trace[1220167518] 'process raft request' (duration: 313.111222ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:24.881604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:42:24.56798Z","time spent":"313.409861ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T14:42:24.881655Z","caller":"traceutil/trace.go:171","msg":"trace[300457502] linearizableReadLoop","detail":"{readStateIndex:26928; appliedIndex:26928; }","duration":"257.771604ms","start":"2026-05-28T14:42:24.623828Z","end":"2026-05-28T14:42:24.8816Z","steps":["trace[300457502] 'read index received' (duration: 257.736453ms)","trace[300457502] 'applied index is now lower than readState.Index' (duration: 31.591µs)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:42:24.882147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.285437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-05-28T14:42:24.882332Z","caller":"traceutil/trace.go:171","msg":"trace[293068294] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:26064; }","duration":"258.537925ms","start":"2026-05-28T14:42:24.623751Z","end":"2026-05-28T14:42:24.882289Z","steps":["trace[293068294] 'agreement among raft nodes before linearized reading' (duration: 258.146024ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:24.88251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.602253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:42:24.882611Z","caller":"traceutil/trace.go:171","msg":"trace[2079478911] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:26064; }","duration":"196.816889ms","start":"2026-05-28T14:42:24.685757Z","end":"2026-05-28T14:42:24.882574Z","steps":["trace[2079478911] 'agreement among raft nodes before linearized reading' (duration: 196.557701ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:28.268295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.682069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-28T14:42:28.268441Z","caller":"traceutil/trace.go:171","msg":"trace[332189363] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:26096; }","duration":"148.882624ms","start":"2026-05-28T14:42:28.119531Z","end":"2026-05-28T14:42:28.268414Z","steps":["trace[332189363] 'count revisions from in-memory index tree' (duration: 148.556215ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:28.392139Z","caller":"traceutil/trace.go:171","msg":"trace[1072376224] transaction","detail":"{read_only:false; response_revision:26097; number_of_response:1; }","duration":"121.638782ms","start":"2026-05-28T14:42:28.270479Z","end":"2026-05-28T14:42:28.392118Z","steps":["trace[1072376224] 'process raft request' (duration: 121.261642ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:30.527548Z","caller":"traceutil/trace.go:171","msg":"trace[537615145] transaction","detail":"{read_only:false; response_revision:26113; number_of_response:1; }","duration":"129.012515ms","start":"2026-05-28T14:42:30.398501Z","end":"2026-05-28T14:42:30.527513Z","steps":["trace[537615145] 'process raft request' (duration: 128.249254ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:34.655331Z","caller":"traceutil/trace.go:171","msg":"trace[1225214777] transaction","detail":"{read_only:false; response_revision:26143; number_of_response:1; }","duration":"109.69521ms","start":"2026-05-28T14:42:34.545597Z","end":"2026-05-28T14:42:34.655292Z","steps":["trace[1225214777] 'process raft request' (duration: 109.439533ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:48.848613Z","caller":"traceutil/trace.go:171","msg":"trace[95496196] linearizableReadLoop","detail":"{readStateIndex:27123; appliedIndex:27122; }","duration":"119.860523ms","start":"2026-05-28T14:42:48.728716Z","end":"2026-05-28T14:42:48.848577Z","steps":["trace[95496196] 'read index received' (duration: 119.560744ms)","trace[95496196] 'applied index is now lower than readState.Index' (duration: 298.119µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:48.848677Z","caller":"traceutil/trace.go:171","msg":"trace[215663534] transaction","detail":"{read_only:false; response_revision:26254; number_of_response:1; }","duration":"148.468113ms","start":"2026-05-28T14:42:48.700177Z","end":"2026-05-28T14:42:48.848645Z","steps":["trace[215663534] 'process raft request' (duration: 148.170804ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:48.848818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.077798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:42:48.848864Z","caller":"traceutil/trace.go:171","msg":"trace[896437673] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:26254; }","duration":"120.16541ms","start":"2026-05-28T14:42:48.728688Z","end":"2026-05-28T14:42:48.848853Z","steps":["trace[896437673] 'agreement among raft nodes before linearized reading' (duration: 120.049277ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:49.207572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.596157ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-28T14:42:49.207913Z","caller":"traceutil/trace.go:171","msg":"trace[730554054] transaction","detail":"{read_only:false; response_revision:26255; number_of_response:1; }","duration":"442.119676ms","start":"2026-05-28T14:42:48.76574Z","end":"2026-05-28T14:42:49.20786Z","steps":["trace[730554054] 'process raft request' (duration: 306.094337ms)","trace[730554054] 'compare' (duration: 135.160696ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:49.20799Z","caller":"traceutil/trace.go:171","msg":"trace[2018184279] linearizableReadLoop","detail":"{readStateIndex:27124; appliedIndex:27123; }","duration":"359.200876ms","start":"2026-05-28T14:42:48.848745Z","end":"2026-05-28T14:42:49.207946Z","steps":["trace[2018184279] 'read index received' (duration: 223.080324ms)","trace[2018184279] 'applied index is now lower than readState.Index' (duration: 136.115442ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:42:49.208143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:42:48.765724Z","time spent":"442.300322ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T14:42:49.208171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.628489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:42:49.208259Z","caller":"traceutil/trace.go:171","msg":"trace[584764138] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26255; }","duration":"447.779063ms","start":"2026-05-28T14:42:48.760456Z","end":"2026-05-28T14:42:49.208235Z","steps":["trace[584764138] 'agreement among raft nodes before linearized reading' (duration: 447.590008ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:49.208304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:42:48.760413Z","time spent":"447.883646ms","remote":"127.0.0.1:49630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-28T14:42:49.208875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.16056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-05-28T14:42:49.208947Z","caller":"traceutil/trace.go:171","msg":"trace[1335326737] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26256; }","duration":"205.260723ms","start":"2026-05-28T14:42:49.003661Z","end":"2026-05-28T14:42:49.208922Z","steps":["trace[1335326737] 'agreement among raft nodes before linearized reading' (duration: 205.022196ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:49.209119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.271538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:42:49.209208Z","caller":"traceutil/trace.go:171","msg":"trace[243308581] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26256; }","duration":"114.393541ms","start":"2026-05-28T14:42:49.094791Z","end":"2026-05-28T14:42:49.209184Z","steps":["trace[243308581] 'agreement among raft nodes before linearized reading' (duration: 114.268848ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:49.504864Z","caller":"traceutil/trace.go:171","msg":"trace[1989864416] transaction","detail":"{read_only:false; response_revision:26257; number_of_response:1; }","duration":"291.248038ms","start":"2026-05-28T14:42:49.213584Z","end":"2026-05-28T14:42:49.504832Z","steps":["trace[1989864416] 'process raft request' (duration: 252.198229ms)","trace[1989864416] 'compare' (duration: 38.891245ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:42:49.754936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.774973ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-28T14:42:49.755087Z","caller":"traceutil/trace.go:171","msg":"trace[2010294634] transaction","detail":"{read_only:false; response_revision:26258; number_of_response:1; }","duration":"427.443882ms","start":"2026-05-28T14:42:49.327605Z","end":"2026-05-28T14:42:49.755049Z","steps":["trace[2010294634] 'process raft request' (duration: 304.466624ms)","trace[2010294634] 'compare' (duration: 122.636959ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:49.75514Z","caller":"traceutil/trace.go:171","msg":"trace[1340413979] transaction","detail":"{read_only:false; response_revision:26259; number_of_response:1; }","duration":"227.421474ms","start":"2026-05-28T14:42:49.527702Z","end":"2026-05-28T14:42:49.755123Z","steps":["trace[1340413979] 'process raft request' (duration: 227.348252ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:49.755185Z","caller":"traceutil/trace.go:171","msg":"trace[788634226] linearizableReadLoop","detail":"{readStateIndex:27127; appliedIndex:27125; }","duration":"307.278541ms","start":"2026-05-28T14:42:49.447876Z","end":"2026-05-28T14:42:49.755154Z","steps":["trace[788634226] 'read index received' (duration: 17.768621ms)","trace[788634226] 'applied index is now lower than readState.Index' (duration: 289.50708ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:42:49.755236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:42:49.327565Z","time spent":"427.586596ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T14:42:49.755447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.551039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-05-28T14:42:49.755519Z","caller":"traceutil/trace.go:171","msg":"trace[71348598] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:26259; }","duration":"307.694523ms","start":"2026-05-28T14:42:49.447807Z","end":"2026-05-28T14:42:49.755502Z","steps":["trace[71348598] 'agreement among raft nodes before linearized reading' (duration: 307.448466ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:49.75556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T14:42:49.44778Z","time spent":"307.771855ms","remote":"127.0.0.1:49978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":180,"response size":33,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"info","ts":"2026-05-28T14:42:49.906111Z","caller":"traceutil/trace.go:171","msg":"trace[923925261] linearizableReadLoop","detail":"{readStateIndex:27132; appliedIndex:27128; }","duration":"150.840379ms","start":"2026-05-28T14:42:49.755248Z","end":"2026-05-28T14:42:49.906088Z","steps":["trace[923925261] 'read index received' (duration: 10.773928ms)","trace[923925261] 'applied index is now lower than readState.Index' (duration: 140.065741ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:49.906257Z","caller":"traceutil/trace.go:171","msg":"trace[1259981063] transaction","detail":"{read_only:false; response_revision:26261; number_of_response:1; }","duration":"232.899276ms","start":"2026-05-28T14:42:49.67333Z","end":"2026-05-28T14:42:49.906229Z","steps":["trace[1259981063] 'process raft request' (duration: 232.495065ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:49.906327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.951681ms","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-28T14:42:49.906361Z","caller":"traceutil/trace.go:171","msg":"trace[1973136964] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26263; }","duration":"223.057064ms","start":"2026-05-28T14:42:49.683295Z","end":"2026-05-28T14:42:49.906353Z","steps":["trace[1973136964] 'agreement among raft nodes before linearized reading' (duration: 222.881649ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:49.906638Z","caller":"traceutil/trace.go:171","msg":"trace[684657369] transaction","detail":"{read_only:false; response_revision:26262; number_of_response:1; }","duration":"233.288506ms","start":"2026-05-28T14:42:49.673342Z","end":"2026-05-28T14:42:49.90663Z","steps":["trace[684657369] 'process raft request' (duration: 232.664469ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:49.906718Z","caller":"traceutil/trace.go:171","msg":"trace[1456798202] transaction","detail":"{read_only:false; response_revision:26263; number_of_response:1; }","duration":"214.707704ms","start":"2026-05-28T14:42:49.692005Z","end":"2026-05-28T14:42:49.906712Z","steps":["trace[1456798202] 'process raft request' (duration: 214.043515ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:50.204518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.189416ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-28T14:42:50.204654Z","caller":"traceutil/trace.go:171","msg":"trace[1499965089] linearizableReadLoop","detail":"{readStateIndex:27133; appliedIndex:27132; }","duration":"198.319121ms","start":"2026-05-28T14:42:50.006316Z","end":"2026-05-28T14:42:50.204635Z","steps":["trace[1499965089] 'read index received' (duration: 41.925009ms)","trace[1499965089] 'applied index is now lower than readState.Index' (duration: 156.392742ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:50.204715Z","caller":"traceutil/trace.go:171","msg":"trace[422029828] transaction","detail":"{read_only:false; response_revision:26264; number_of_response:1; }","duration":"219.790873ms","start":"2026-05-28T14:42:49.984874Z","end":"2026-05-28T14:42:50.204665Z","steps":["trace[422029828] 'process raft request' (duration: 63.372301ms)","trace[422029828] 'compare' (duration: 156.068283ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:42:50.204799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.481945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:42:50.204832Z","caller":"traceutil/trace.go:171","msg":"trace[1448449527] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26264; }","duration":"198.546977ms","start":"2026-05-28T14:42:50.006274Z","end":"2026-05-28T14:42:50.204821Z","steps":["trace[1448449527] 'agreement among raft nodes before linearized reading' (duration: 198.464084ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:50.204854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.631332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:42:50.204918Z","caller":"traceutil/trace.go:171","msg":"trace[1102622306] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:26264; }","duration":"197.738874ms","start":"2026-05-28T14:42:50.007163Z","end":"2026-05-28T14:42:50.204902Z","steps":["trace[1102622306] 'agreement among raft nodes before linearized reading' (duration: 197.61465ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:50.204908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.345477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-05-28T14:42:50.204966Z","caller":"traceutil/trace.go:171","msg":"trace[1697388789] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26264; }","duration":"174.44628ms","start":"2026-05-28T14:42:50.030504Z","end":"2026-05-28T14:42:50.20495Z","steps":["trace[1697388789] 'agreement among raft nodes before linearized reading' (duration: 174.280856ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:50.204957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.256584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-05-28T14:42:50.204991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.4787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-28T14:42:50.205023Z","caller":"traceutil/trace.go:171","msg":"trace[1329633305] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26264; }","duration":"179.358587ms","start":"2026-05-28T14:42:50.02565Z","end":"2026-05-28T14:42:50.205008Z","steps":["trace[1329633305] 'agreement among raft nodes before linearized reading' (duration: 179.188622ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:50.205046Z","caller":"traceutil/trace.go:171","msg":"trace[1341601799] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26264; }","duration":"179.549622ms","start":"2026-05-28T14:42:50.025483Z","end":"2026-05-28T14:42:50.205033Z","steps":["trace[1341601799] 'agreement among raft nodes before linearized reading' (duration: 179.391907ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:50.205069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.051888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-28T14:42:50.205099Z","caller":"traceutil/trace.go:171","msg":"trace[902090819] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26264; }","duration":"111.11486ms","start":"2026-05-28T14:42:50.093976Z","end":"2026-05-28T14:42:50.205091Z","steps":["trace[902090819] 'agreement among raft nodes before linearized reading' (duration: 111.061459ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:50.204992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.510363ms","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-28T14:42:50.205141Z","caller":"traceutil/trace.go:171","msg":"trace[506451081] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26264; }","duration":"174.703857ms","start":"2026-05-28T14:42:50.030429Z","end":"2026-05-28T14:42:50.205133Z","steps":["trace[506451081] 'agreement among raft nodes before linearized reading' (duration: 174.42889ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:50.357719Z","caller":"traceutil/trace.go:171","msg":"trace[1203570046] transaction","detail":"{read_only:false; response_revision:26267; number_of_response:1; }","duration":"145.544762ms","start":"2026-05-28T14:42:50.212149Z","end":"2026-05-28T14:42:50.357693Z","steps":["trace[1203570046] 'process raft request' (duration: 145.46463ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:50.357767Z","caller":"traceutil/trace.go:171","msg":"trace[858322576] transaction","detail":"{read_only:false; response_revision:26266; number_of_response:1; }","duration":"145.606724ms","start":"2026-05-28T14:42:50.212117Z","end":"2026-05-28T14:42:50.357723Z","steps":["trace[858322576] 'process raft request' (duration: 127.763191ms)","trace[858322576] 'compare' (duration: 17.615657ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:50.357912Z","caller":"traceutil/trace.go:171","msg":"trace[1027126423] linearizableReadLoop","detail":"{readStateIndex:27137; appliedIndex:27134; }","duration":"144.174364ms","start":"2026-05-28T14:42:50.213707Z","end":"2026-05-28T14:42:50.357881Z","steps":["trace[1027126423] 'read index received' (duration: 19.209251ms)","trace[1027126423] 'applied index is now lower than readState.Index' (duration: 124.963283ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:42:50.357952Z","caller":"traceutil/trace.go:171","msg":"trace[1151615268] transaction","detail":"{read_only:false; response_revision:26268; number_of_response:1; }","duration":"145.789369ms","start":"2026-05-28T14:42:50.212149Z","end":"2026-05-28T14:42:50.357939Z","steps":["trace[1151615268] 'process raft request' (duration: 145.512141ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:50.358145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.417291ms","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-28T14:42:50.358198Z","caller":"traceutil/trace.go:171","msg":"trace[1475597922] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26268; }","duration":"144.507953ms","start":"2026-05-28T14:42:50.213679Z","end":"2026-05-28T14:42:50.358187Z","steps":["trace[1475597922] 'agreement among raft nodes before linearized reading' (duration: 144.307287ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:42:50.642496Z","caller":"traceutil/trace.go:171","msg":"trace[2014984875] transaction","detail":"{read_only:false; response_revision:26269; number_of_response:1; }","duration":"130.531057ms","start":"2026-05-28T14:42:50.511942Z","end":"2026-05-28T14:42:50.642473Z","steps":["trace[2014984875] 'process raft request' (duration: 130.374173ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:42:57.958375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.15661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-28T14:42:57.958723Z","caller":"traceutil/trace.go:171","msg":"trace[716942123] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:26320; }","duration":"116.289093ms","start":"2026-05-28T14:42:57.842153Z","end":"2026-05-28T14:42:57.958442Z","steps":["trace[716942123] 'count revisions from in-memory index tree' (duration: 116.067507ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:43:03.975053Z","caller":"traceutil/trace.go:171","msg":"trace[1314451283] transaction","detail":"{read_only:false; response_revision:26371; number_of_response:1; }","duration":"170.109381ms","start":"2026-05-28T14:43:03.804899Z","end":"2026-05-28T14:43:03.975008Z","steps":["trace[1314451283] 'process raft request' (duration: 133.254012ms)","trace[1314451283] 'compare' (duration: 36.602232ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:43:04.002693Z","caller":"traceutil/trace.go:171","msg":"trace[400820462] linearizableReadLoop","detail":"{readStateIndex:27244; appliedIndex:27242; }","duration":"106.120703ms","start":"2026-05-28T14:43:03.896531Z","end":"2026-05-28T14:43:04.002651Z","steps":["trace[400820462] 'read index received' (duration: 41.629251ms)","trace[400820462] 'applied index is now lower than readState.Index' (duration: 64.490212ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:43:04.002731Z","caller":"traceutil/trace.go:171","msg":"trace[422866591] transaction","detail":"{read_only:false; response_revision:26372; number_of_response:1; }","duration":"197.389465ms","start":"2026-05-28T14:43:03.805316Z","end":"2026-05-28T14:43:04.002706Z","steps":["trace[422866591] 'process raft request' (duration: 197.182129ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T14:43:04.00285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.300127ms","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:6"} {"level":"info","ts":"2026-05-28T14:43:04.002892Z","caller":"traceutil/trace.go:171","msg":"trace[403466980] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:26372; }","duration":"106.366029ms","start":"2026-05-28T14:43:03.896514Z","end":"2026-05-28T14:43:04.00288Z","steps":["trace[403466980] 'agreement among raft nodes before linearized reading' (duration: 106.250496ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:43:04.150526Z","caller":"traceutil/trace.go:171","msg":"trace[1250892373] transaction","detail":"{read_only:false; response_revision:26374; number_of_response:1; }","duration":"170.601765ms","start":"2026-05-28T14:43:03.979907Z","end":"2026-05-28T14:43:04.150509Z","steps":["trace[1250892373] 'process raft request' (duration: 170.538943ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:43:04.150534Z","caller":"traceutil/trace.go:171","msg":"trace[1488156813] transaction","detail":"{read_only:false; response_revision:26373; number_of_response:1; }","duration":"170.711328ms","start":"2026-05-28T14:43:03.979795Z","end":"2026-05-28T14:43:04.150506Z","steps":["trace[1488156813] 'process raft request' (duration: 133.072427ms)","trace[1488156813] 'compare' (duration: 37.370383ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:43:04.150761Z","caller":"traceutil/trace.go:171","msg":"trace[1704601420] transaction","detail":"{read_only:false; response_revision:26375; number_of_response:1; }","duration":"167.027656ms","start":"2026-05-28T14:43:03.983703Z","end":"2026-05-28T14:43:04.15073Z","steps":["trace[1704601420] 'process raft request' (duration: 166.776969ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:43:04.391157Z","caller":"traceutil/trace.go:171","msg":"trace[1638795430] linearizableReadLoop","detail":"{readStateIndex:27248; appliedIndex:27247; }","duration":"100.184948ms","start":"2026-05-28T14:43:04.290949Z","end":"2026-05-28T14:43:04.391134Z","steps":["trace[1638795430] 'read index received' (duration: 100.006923ms)","trace[1638795430] 'applied index is now lower than readState.Index' (duration: 177.005µs)"],"step_count":2} {"level":"warn","ts":"2026-05-28T14:43:04.391373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.417705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-05-28T14:43:04.391406Z","caller":"traceutil/trace.go:171","msg":"trace[992126669] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26376; }","duration":"100.509218ms","start":"2026-05-28T14:43:04.290885Z","end":"2026-05-28T14:43:04.391394Z","steps":["trace[992126669] 'agreement among raft nodes before linearized reading' (duration: 100.349043ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:43:04.391656Z","caller":"traceutil/trace.go:171","msg":"trace[916787368] transaction","detail":"{read_only:false; response_revision:26376; number_of_response:1; }","duration":"139.881865ms","start":"2026-05-28T14:43:04.251763Z","end":"2026-05-28T14:43:04.391645Z","steps":["trace[916787368] 'process raft request' (duration: 139.203857ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:43:14.319078Z","caller":"traceutil/trace.go:171","msg":"trace[1357944397] transaction","detail":"{read_only:false; response_revision:26448; number_of_response:1; }","duration":"120.88336ms","start":"2026-05-28T14:43:14.198162Z","end":"2026-05-28T14:43:14.319046Z","steps":["trace[1357944397] 'process raft request' (duration: 57.467857ms)","trace[1357944397] 'compare' (duration: 63.281659ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:43:14.409248Z","caller":"traceutil/trace.go:171","msg":"trace[1659043528] transaction","detail":"{read_only:false; response_revision:26450; number_of_response:1; }","duration":"210.871267ms","start":"2026-05-28T14:43:14.198344Z","end":"2026-05-28T14:43:14.409215Z","steps":["trace[1659043528] 'process raft request' (duration: 210.805795ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:43:14.409322Z","caller":"traceutil/trace.go:171","msg":"trace[386649366] transaction","detail":"{read_only:false; response_revision:26449; number_of_response:1; }","duration":"211.034271ms","start":"2026-05-28T14:43:14.198244Z","end":"2026-05-28T14:43:14.409278Z","steps":["trace[386649366] 'process raft request' (duration: 210.744553ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T14:43:14.534832Z","caller":"traceutil/trace.go:171","msg":"trace[1514608819] transaction","detail":"{read_only:false; response_revision:26451; number_of_response:1; }","duration":"108.56189ms","start":"2026-05-28T14:43:14.426238Z","end":"2026-05-28T14:43:14.5348Z","steps":["trace[1514608819] 'process raft request' (duration: 33.901687ms)","trace[1514608819] 'compare' (duration: 73.515602ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T14:43:41.814768Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006c25.wal"} {"level":"info","ts":"2026-05-28T14:46:03.037841Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25239} {"level":"info","ts":"2026-05-28T14:46:03.186609Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25239,"took":"144.290465ms","hash":2523260235,"current-db-size-bytes":58388480,"current-db-size":"58 MB","current-db-size-in-use-bytes":37457920,"current-db-size-in-use":"38 MB"} {"level":"info","ts":"2026-05-28T14:46:03.186684Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2523260235,"revision":25239,"compact-revision":22032} {"level":"info","ts":"2026-05-28T14:47:39.433598Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c47ca1a7b1fe506b","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-28T14:47:39.440754Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-05-28T14:47:39.440909Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-05-28T14:51:03.043945Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28090} {"level":"info","ts":"2026-05-28T14:51:03.180082Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28090,"took":"131.860081ms","hash":4001871004,"current-db-size-bytes":58388480,"current-db-size":"58 MB","current-db-size-in-use-bytes":32305152,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-28T14:51:03.180154Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4001871004,"revision":28090,"compact-revision":25239} {"level":"info","ts":"2026-05-28T14:56:03.052931Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30592} {"level":"info","ts":"2026-05-28T14:56:03.190392Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30592,"took":"133.184698ms","hash":3907518549,"current-db-size-bytes":58388480,"current-db-size":"58 MB","current-db-size-in-use-bytes":30281728,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-28T14:56:03.190462Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3907518549,"revision":30592,"compact-revision":28090} {"level":"info","ts":"2026-05-28T15:01:03.058572Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32847} {"level":"info","ts":"2026-05-28T15:01:03.205827Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32847,"took":"144.245129ms","hash":3351545013,"current-db-size-bytes":59432960,"current-db-size":"59 MB","current-db-size-in-use-bytes":31145984,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-28T15:01:03.205902Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3351545013,"revision":32847,"compact-revision":30592} {"level":"info","ts":"2026-05-28T15:06:03.063396Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35195} {"level":"info","ts":"2026-05-28T15:06:03.214075Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35195,"took":"140.678391ms","hash":2709823372,"current-db-size-bytes":59432960,"current-db-size":"59 MB","current-db-size-in-use-bytes":32313344,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-28T15:06:03.214138Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2709823372,"revision":35195,"compact-revision":32847} {"level":"info","ts":"2026-05-28T15:07:06.394866Z","caller":"traceutil/trace.go:171","msg":"trace[1261029938] transaction","detail":"{read_only:false; response_revision:37970; number_of_response:1; }","duration":"619.648501ms","start":"2026-05-28T15:07:05.775192Z","end":"2026-05-28T15:07:06.39484Z","steps":["trace[1261029938] 'process raft request' (duration: 619.495177ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:07:06.395226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:07:05.775167Z","time spent":"619.779754ms","remote":"127.0.0.1:41282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2497,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T15:07:06.396064Z","caller":"traceutil/trace.go:171","msg":"trace[217367616] linearizableReadLoop","detail":"{readStateIndex:39160; appliedIndex:39157; }","duration":"399.157263ms","start":"2026-05-28T15:07:05.996889Z","end":"2026-05-28T15:07:06.396046Z","steps":["trace[217367616] 'read index received' (duration: 397.828107ms)","trace[217367616] 'applied index is now lower than readState.Index' (duration: 1.328436ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T15:07:06.396103Z","caller":"traceutil/trace.go:171","msg":"trace[997561807] transaction","detail":"{read_only:false; response_revision:37972; number_of_response:1; }","duration":"616.145024ms","start":"2026-05-28T15:07:05.779933Z","end":"2026-05-28T15:07:06.396079Z","steps":["trace[997561807] 'process raft request' (duration: 616.055452ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:07:06.396175Z","caller":"traceutil/trace.go:171","msg":"trace[2071552483] transaction","detail":"{read_only:false; response_revision:37973; number_of_response:1; }","duration":"152.168918ms","start":"2026-05-28T15:07:06.243997Z","end":"2026-05-28T15:07:06.396166Z","steps":["trace[2071552483] 'process raft request' (duration: 152.018134ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:07:06.396246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.340959ms","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:8"} {"level":"info","ts":"2026-05-28T15:07:06.39628Z","caller":"traceutil/trace.go:171","msg":"trace[1930649502] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:37973; }","duration":"399.430392ms","start":"2026-05-28T15:07:05.996842Z","end":"2026-05-28T15:07:06.396273Z","steps":["trace[1930649502] 'agreement among raft nodes before linearized reading' (duration: 399.35271ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:07:06.396302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:07:05.996823Z","time spent":"399.471432ms","remote":"127.0.0.1:42306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":32,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-05-28T15:07:06.39639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.543351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-28T15:07:06.396405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:07:05.779913Z","time spent":"616.240807ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T15:07:06.39609Z","caller":"traceutil/trace.go:171","msg":"trace[1901402440] transaction","detail":"{read_only:false; response_revision:37971; number_of_response:1; }","duration":"617.633065ms","start":"2026-05-28T15:07:05.778435Z","end":"2026-05-28T15:07:06.396068Z","steps":["trace[1901402440] 'process raft request' (duration: 617.471851ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:07:06.396437Z","caller":"traceutil/trace.go:171","msg":"trace[2098219041] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:37973; }","duration":"304.619622ms","start":"2026-05-28T15:07:06.091808Z","end":"2026-05-28T15:07:06.396427Z","steps":["trace[2098219041] 'agreement among raft nodes before linearized reading' (duration: 304.54834ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:07:06.396475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:07:06.091794Z","time spent":"304.674924ms","remote":"127.0.0.1:49630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-28T15:07:06.39657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:07:05.77841Z","time spent":"618.058357ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T15:08:56.966014Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c47ca1a7b1fe506b","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-28T15:08:56.970821Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-05-28T15:08:56.970955Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-05-28T15:09:28.755488Z","caller":"traceutil/trace.go:171","msg":"trace[287787495] transaction","detail":"{read_only:false; response_revision:39021; number_of_response:1; }","duration":"482.088514ms","start":"2026-05-28T15:09:28.273363Z","end":"2026-05-28T15:09:28.755451Z","steps":["trace[287787495] 'process raft request' (duration: 481.802886ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:09:28.75568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:09:28.273339Z","time spent":"482.256519ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T15:09:28.758847Z","caller":"traceutil/trace.go:171","msg":"trace[1669138608] transaction","detail":"{read_only:false; response_revision:39022; number_of_response:1; }","duration":"482.894716ms","start":"2026-05-28T15:09:28.275925Z","end":"2026-05-28T15:09:28.75882Z","steps":["trace[1669138608] 'process raft request' (duration: 482.734921ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:09:28.758993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:09:28.27591Z","time spent":"483.00533ms","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T15:11:03.073117Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37472} {"level":"info","ts":"2026-05-28T15:11:03.194835Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37472,"took":"118.38192ms","hash":881960732,"current-db-size-bytes":61120512,"current-db-size":"61 MB","current-db-size-in-use-bytes":32477184,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-28T15:11:03.19492Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":881960732,"revision":37472,"compact-revision":35195} {"level":"info","ts":"2026-05-28T15:16:03.082972Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39747} {"level":"info","ts":"2026-05-28T15:16:03.206247Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39747,"took":"120.270112ms","hash":2715650016,"current-db-size-bytes":61120512,"current-db-size":"61 MB","current-db-size-in-use-bytes":30654464,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-28T15:16:03.206302Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2715650016,"revision":39747,"compact-revision":37472}