{"level":"warn","ts":"2026-09-08T22:55:13.082621Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-08T22:55:13.082727Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.82: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://162.253.55.82:2380","--initial-cluster=instance=https://162.253.55.82:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.82:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.82: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-09-08T22:55:13.082805Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-08T22:55:13.082816Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.82:2380"]} {"level":"info","ts":"2026-09-08T22:55:13.082838Z","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-09-08T22:55:13.083578Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.82:2379"]} {"level":"info","ts":"2026-09-08T22:55:13.08367Z","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://162.253.55.82:2380"],"listen-peer-urls":["https://162.253.55.82:2380"],"advertise-client-urls":["https://162.253.55.82:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.82:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.82: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-09-08T22:55:13.088285Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.353249ms"} {"level":"info","ts":"2026-09-08T22:55:13.096776Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c5298098e2dc0f92","cluster-id":"e15b04acbd0c3f73"} {"level":"info","ts":"2026-09-08T22:55:13.09685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 switched to configuration voters=()"} {"level":"info","ts":"2026-09-08T22:55:13.096869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became follower at term 0"} {"level":"info","ts":"2026-09-08T22:55:13.096879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c5298098e2dc0f92 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-08T22:55:13.097001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became follower at term 1"} {"level":"info","ts":"2026-09-08T22:55:13.097045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 switched to configuration voters=(14207027893646397330)"} {"level":"warn","ts":"2026-09-08T22:55:13.104625Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-08T22:55:13.106245Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-08T22:55:13.107732Z","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-09-08T22:55:13.110147Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c5298098e2dc0f92","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-08T22:55:13.110419Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c5298098e2dc0f92","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-08T22:55:13.110613Z","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-09-08T22:55:13.110775Z","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-09-08T22:55:13.110794Z","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-09-08T22:55:13.113025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 switched to configuration voters=(14207027893646397330)"} {"level":"info","ts":"2026-09-08T22:55:13.113387Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e15b04acbd0c3f73","local-member-id":"c5298098e2dc0f92","added-peer-id":"c5298098e2dc0f92","added-peer-peer-urls":["https://162.253.55.82:2380"]} {"level":"info","ts":"2026-09-08T22:55:13.115807Z","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-09-08T22:55:13.116085Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.82:2380"} {"level":"info","ts":"2026-09-08T22:55:13.11618Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.82:2380"} {"level":"info","ts":"2026-09-08T22:55:13.116349Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c5298098e2dc0f92","initial-advertise-peer-urls":["https://162.253.55.82:2380"],"listen-peer-urls":["https://162.253.55.82:2380"],"advertise-client-urls":["https://162.253.55.82:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.82:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-08T22:55:13.1164Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-08T22:55:13.397651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 is starting a new election at term 1"} {"level":"info","ts":"2026-09-08T22:55:13.397792Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-08T22:55:13.397832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 received MsgPreVoteResp from c5298098e2dc0f92 at term 1"} {"level":"info","ts":"2026-09-08T22:55:13.397859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became candidate at term 2"} {"level":"info","ts":"2026-09-08T22:55:13.397871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 received MsgVoteResp from c5298098e2dc0f92 at term 2"} {"level":"info","ts":"2026-09-08T22:55:13.397889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became leader at term 2"} {"level":"info","ts":"2026-09-08T22:55:13.397912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c5298098e2dc0f92 elected leader c5298098e2dc0f92 at term 2"} {"level":"info","ts":"2026-09-08T22:55:13.399214Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c5298098e2dc0f92","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.82:2379]}","request-path":"/0/members/c5298098e2dc0f92/attributes","cluster-id":"e15b04acbd0c3f73","publish-timeout":"7s"} {"level":"info","ts":"2026-09-08T22:55:13.399242Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-08T22:55:13.399323Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-08T22:55:13.39937Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-08T22:55:13.399766Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-08T22:55:13.399862Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-08T22:55:13.401437Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e15b04acbd0c3f73","local-member-id":"c5298098e2dc0f92","cluster-version":"3.5"} {"level":"info","ts":"2026-09-08T22:55:13.401691Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-08T22:55:13.401764Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-08T22:55:13.403014Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.82:2379"} {"level":"info","ts":"2026-09-08T22:55:13.40389Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-08T22:56:09.449715Z","caller":"traceutil/trace.go:171","msg":"trace[910166225] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:678; }","duration":"280.033914ms","start":"2026-09-08T22:56:09.169643Z","end":"2026-09-08T22:56:09.449677Z","steps":["trace[910166225] 'read index received' (duration: 278.85ms)","trace[910166225] 'applied index is now lower than readState.Index' (duration: 1.182574ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T22:56:09.449809Z","caller":"traceutil/trace.go:171","msg":"trace[1072648707] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"472.973856ms","start":"2026-09-08T22:56:08.976777Z","end":"2026-09-08T22:56:09.44975Z","steps":["trace[1072648707] 'process raft request' (duration: 472.001407ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:56:09.450002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.315123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-l6gmx\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-08T22:56:09.450113Z","caller":"traceutil/trace.go:171","msg":"trace[531253811] range","detail":"{range_begin:/registry/pods/kube-system/cilium-l6gmx; range_end:; response_count:1; response_revision:656; }","duration":"280.525449ms","start":"2026-09-08T22:56:09.169571Z","end":"2026-09-08T22:56:09.450096Z","steps":["trace[531253811] 'agreement among raft nodes before linearized reading' (duration: 280.312383ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:56:09.450368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.066177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-08T22:56:09.450531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.454923ms","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-09-08T22:56:09.450636Z","caller":"traceutil/trace.go:171","msg":"trace[664997928] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:656; }","duration":"112.607707ms","start":"2026-09-08T22:56:09.337999Z","end":"2026-09-08T22:56:09.450606Z","steps":["trace[664997928] 'agreement among raft nodes before linearized reading' (duration: 112.326979ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T22:56:09.450546Z","caller":"traceutil/trace.go:171","msg":"trace[518102296] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:656; }","duration":"229.332904ms","start":"2026-09-08T22:56:09.221161Z","end":"2026-09-08T22:56:09.450494Z","steps":["trace[518102296] 'agreement among raft nodes before linearized reading' (duration: 229.037516ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:56:09.450607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.182619ms","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-09-08T22:56:09.450807Z","caller":"traceutil/trace.go:171","msg":"trace[699653884] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:656; }","duration":"107.427396ms","start":"2026-09-08T22:56:09.343309Z","end":"2026-09-08T22:56:09.450736Z","steps":["trace[699653884] 'agreement among raft nodes before linearized reading' (duration: 106.978213ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:56:09.450772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T22:56:08.976731Z","time spent":"473.208763ms","remote":"127.0.0.1:56406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T22:56:27.160389Z","caller":"traceutil/trace.go:171","msg":"trace[1234217078] transaction","detail":"{read_only:false; response_revision:831; number_of_response:1; }","duration":"216.726357ms","start":"2026-09-08T22:56:26.943619Z","end":"2026-09-08T22:56:27.160345Z","steps":["trace[1234217078] 'process raft request' (duration: 216.206381ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T22:57:45.882094Z","caller":"traceutil/trace.go:171","msg":"trace[1205984931] linearizableReadLoop","detail":"{readStateIndex:1974; appliedIndex:1973; }","duration":"180.860708ms","start":"2026-09-08T22:57:45.701205Z","end":"2026-09-08T22:57:45.882065Z","steps":["trace[1205984931] 'read index received' (duration: 180.621801ms)","trace[1205984931] 'applied index is now lower than readState.Index' (duration: 237.867µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T22:57:45.882213Z","caller":"traceutil/trace.go:171","msg":"trace[1216082677] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"297.897526ms","start":"2026-09-08T22:57:45.584244Z","end":"2026-09-08T22:57:45.882141Z","steps":["trace[1216082677] 'process raft request' (duration: 297.646898ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:57:45.882316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.308724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T22:57:45.882371Z","caller":"traceutil/trace.go:171","msg":"trace[367000623] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1904; }","duration":"148.383506ms","start":"2026-09-08T22:57:45.733965Z","end":"2026-09-08T22:57:45.882349Z","steps":["trace[367000623] 'agreement among raft nodes before linearized reading' (duration: 148.278663ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:57:45.88241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.165427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5b458c76-db77-4d4a-a5c4-5264dab0e049\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-09-08T22:57:45.88254Z","caller":"traceutil/trace.go:171","msg":"trace[937435676] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5b458c76-db77-4d4a-a5c4-5264dab0e049; range_end:; response_count:1; response_revision:1904; }","duration":"181.380563ms","start":"2026-09-08T22:57:45.701131Z","end":"2026-09-08T22:57:45.882512Z","steps":["trace[937435676] 'agreement among raft nodes before linearized reading' (duration: 181.063514ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T22:57:46.318566Z","caller":"traceutil/trace.go:171","msg":"trace[982014351] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"281.32658ms","start":"2026-09-08T22:57:46.037212Z","end":"2026-09-08T22:57:46.318539Z","steps":["trace[982014351] 'process raft request' (duration: 281.174966ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T22:57:46.393374Z","caller":"traceutil/trace.go:171","msg":"trace[599564629] linearizableReadLoop","detail":"{readStateIndex:1977; appliedIndex:1975; }","duration":"172.956796ms","start":"2026-09-08T22:57:46.220391Z","end":"2026-09-08T22:57:46.393348Z","steps":["trace[599564629] 'read index received' (duration: 98.022701ms)","trace[599564629] 'applied index is now lower than readState.Index' (duration: 74.933045ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T22:57:46.393504Z","caller":"traceutil/trace.go:171","msg":"trace[1267093706] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"354.501433ms","start":"2026-09-08T22:57:46.038949Z","end":"2026-09-08T22:57:46.393451Z","steps":["trace[1267093706] 'process raft request' (duration: 342.024318ms)","trace[1267093706] 'compare' (duration: 12.240428ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T22:57:46.393539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.122961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T22:57:46.393601Z","caller":"traceutil/trace.go:171","msg":"trace[1649347651] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1907; }","duration":"173.220374ms","start":"2026-09-08T22:57:46.220364Z","end":"2026-09-08T22:57:46.393584Z","steps":["trace[1649347651] 'agreement among raft nodes before linearized reading' (duration: 173.07661ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:57:46.393697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T22:57:46.038931Z","time spent":"354.638247ms","remote":"127.0.0.1:56562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T22:58:00.110947Z","caller":"traceutil/trace.go:171","msg":"trace[939040336] transaction","detail":"{read_only:false; response_revision:2026; number_of_response:1; }","duration":"142.886272ms","start":"2026-09-08T22:57:59.96804Z","end":"2026-09-08T22:58:00.110927Z","steps":["trace[939040336] 'process raft request' (duration: 142.752359ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T22:58:35.650954Z","caller":"traceutil/trace.go:171","msg":"trace[993983825] transaction","detail":"{read_only:false; response_revision:2233; number_of_response:1; }","duration":"194.388386ms","start":"2026-09-08T22:58:35.456541Z","end":"2026-09-08T22:58:35.65093Z","steps":["trace[993983825] 'process raft request' (duration: 194.237911ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:58:35.885211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.347485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-08T22:58:35.885337Z","caller":"traceutil/trace.go:171","msg":"trace[41127664] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2233; }","duration":"142.555572ms","start":"2026-09-08T22:58:35.742757Z","end":"2026-09-08T22:58:35.885313Z","steps":["trace[41127664] 'range keys from in-memory index tree' (duration: 142.121569ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T22:59:26.009859Z","caller":"traceutil/trace.go:171","msg":"trace[1372536598] transaction","detail":"{read_only:false; response_revision:2677; number_of_response:1; }","duration":"184.393686ms","start":"2026-09-08T22:59:25.825437Z","end":"2026-09-08T22:59:26.009831Z","steps":["trace[1372536598] 'process raft request' (duration: 184.1876ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T22:59:58.948063Z","caller":"traceutil/trace.go:171","msg":"trace[1926852892] transaction","detail":"{read_only:false; response_revision:2874; number_of_response:1; }","duration":"121.784538ms","start":"2026-09-08T22:59:58.826251Z","end":"2026-09-08T22:59:58.948036Z","steps":["trace[1926852892] 'process raft request' (duration: 121.599671ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:59:59.198429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.643238ms","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-09-08T22:59:59.19855Z","caller":"traceutil/trace.go:171","msg":"trace[281246221] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2874; }","duration":"102.786422ms","start":"2026-09-08T22:59:59.095737Z","end":"2026-09-08T22:59:59.198523Z","steps":["trace[281246221] 'range keys from in-memory index tree' (duration: 102.469893ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:59:59.198574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.173416ms","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-09-08T22:59:59.198691Z","caller":"traceutil/trace.go:171","msg":"trace[444134033] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2874; }","duration":"151.254639ms","start":"2026-09-08T22:59:59.047353Z","end":"2026-09-08T22:59:59.198608Z","steps":["trace[444134033] 'range keys from in-memory index tree' (duration: 150.672931ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:59:59.198429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.321783ms","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-09-08T22:59:59.198861Z","caller":"traceutil/trace.go:171","msg":"trace[716159548] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2874; }","duration":"210.838438ms","start":"2026-09-08T22:59:58.988007Z","end":"2026-09-08T22:59:59.198845Z","steps":["trace[716159548] 'range keys from in-memory index tree' (duration: 210.171829ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:59:59.198432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.816983ms","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-09-08T22:59:59.198972Z","caller":"traceutil/trace.go:171","msg":"trace[616998063] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2874; }","duration":"103.431741ms","start":"2026-09-08T22:59:59.095519Z","end":"2026-09-08T22:59:59.198951Z","steps":["trace[616998063] 'range keys from in-memory index tree' (duration: 102.535505ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:02:34.845405Z","caller":"traceutil/trace.go:171","msg":"trace[799667755] transaction","detail":"{read_only:false; response_revision:3817; number_of_response:1; }","duration":"110.980354ms","start":"2026-09-08T23:02:34.734389Z","end":"2026-09-08T23:02:34.845369Z","steps":["trace[799667755] 'process raft request' (duration: 82.967035ms)","trace[799667755] 'compare' (duration: 27.744331ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:03:08.319319Z","caller":"traceutil/trace.go:171","msg":"trace[619899372] linearizableReadLoop","detail":"{readStateIndex:4225; appliedIndex:4224; }","duration":"129.968968ms","start":"2026-09-08T23:03:08.189312Z","end":"2026-09-08T23:03:08.319281Z","steps":["trace[619899372] 'read index received' (duration: 129.695591ms)","trace[619899372] 'applied index is now lower than readState.Index' (duration: 271.437µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:03:08.319356Z","caller":"traceutil/trace.go:171","msg":"trace[1635576793] transaction","detail":"{read_only:false; response_revision:4073; number_of_response:1; }","duration":"141.806586ms","start":"2026-09-08T23:03:08.177509Z","end":"2026-09-08T23:03:08.319316Z","steps":["trace[1635576793] 'process raft request' (duration: 141.519017ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:03:08.319697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.34847ms","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-09-08T23:03:08.319818Z","caller":"traceutil/trace.go:171","msg":"trace[2128169146] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4073; }","duration":"130.539036ms","start":"2026-09-08T23:03:08.189255Z","end":"2026-09-08T23:03:08.319794Z","steps":["trace[2128169146] 'agreement among raft nodes before linearized reading' (duration: 130.237127ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:03:08.394736Z","caller":"traceutil/trace.go:171","msg":"trace[1406655935] transaction","detail":"{read_only:false; response_revision:4074; number_of_response:1; }","duration":"173.308815ms","start":"2026-09-08T23:03:08.221394Z","end":"2026-09-08T23:03:08.394703Z","steps":["trace[1406655935] 'process raft request' (duration: 173.11178ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:03:08.394973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.153321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T23:03:08.394988Z","caller":"traceutil/trace.go:171","msg":"trace[572687964] transaction","detail":"{read_only:false; response_revision:4075; number_of_response:1; }","duration":"166.705734ms","start":"2026-09-08T23:03:08.228234Z","end":"2026-09-08T23:03:08.39494Z","steps":["trace[572687964] 'process raft request' (duration: 166.421285ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:03:08.395034Z","caller":"traceutil/trace.go:171","msg":"trace[809540874] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4075; }","duration":"174.260474ms","start":"2026-09-08T23:03:08.220757Z","end":"2026-09-08T23:03:08.395018Z","steps":["trace[809540874] 'agreement among raft nodes before linearized reading' (duration: 174.151281ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:03:08.395057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.717357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-09-08T23:03:08.395092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.327876ms","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-09-08T23:03:08.395105Z","caller":"traceutil/trace.go:171","msg":"trace[837275276] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4075; }","duration":"187.788009ms","start":"2026-09-08T23:03:08.207301Z","end":"2026-09-08T23:03:08.395089Z","steps":["trace[837275276] 'agreement among raft nodes before linearized reading' (duration: 187.628995ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:03:08.395176Z","caller":"traceutil/trace.go:171","msg":"trace[1179018450] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4075; }","duration":"187.438159ms","start":"2026-09-08T23:03:08.20772Z","end":"2026-09-08T23:03:08.395158Z","steps":["trace[1179018450] 'agreement among raft nodes before linearized reading' (duration: 187.204403ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:04:36.815461Z","caller":"traceutil/trace.go:171","msg":"trace[871468879] transaction","detail":"{read_only:false; response_revision:5070; number_of_response:1; }","duration":"126.647887ms","start":"2026-09-08T23:04:36.688788Z","end":"2026-09-08T23:04:36.815436Z","steps":["trace[871468879] 'process raft request' (duration: 126.491333ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:04:36.876201Z","caller":"traceutil/trace.go:171","msg":"trace[1843635451] transaction","detail":"{read_only:false; response_revision:5072; number_of_response:1; }","duration":"121.354494ms","start":"2026-09-08T23:04:36.754833Z","end":"2026-09-08T23:04:36.876187Z","steps":["trace[1843635451] 'process raft request' (duration: 121.241891ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:04:36.876182Z","caller":"traceutil/trace.go:171","msg":"trace[1019406649] transaction","detail":"{read_only:false; response_revision:5071; number_of_response:1; }","duration":"128.39273ms","start":"2026-09-08T23:04:36.747757Z","end":"2026-09-08T23:04:36.87615Z","steps":["trace[1019406649] 'process raft request' (duration: 97.945798ms)","trace[1019406649] 'compare' (duration: 30.303378ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:04:36.876332Z","caller":"traceutil/trace.go:171","msg":"trace[256840760] transaction","detail":"{read_only:false; response_revision:5073; number_of_response:1; }","duration":"102.494801ms","start":"2026-09-08T23:04:36.773821Z","end":"2026-09-08T23:04:36.876316Z","steps":["trace[256840760] 'process raft request' (duration: 102.318686ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:04:43.149067Z","caller":"traceutil/trace.go:171","msg":"trace[2129055981] linearizableReadLoop","detail":"{readStateIndex:5484; appliedIndex:5482; }","duration":"229.972893ms","start":"2026-09-08T23:04:42.919069Z","end":"2026-09-08T23:04:43.149042Z","steps":["trace[2129055981] 'read index received' (duration: 56.285808ms)","trace[2129055981] 'applied index is now lower than readState.Index' (duration: 173.685935ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:04:43.1491Z","caller":"traceutil/trace.go:171","msg":"trace[1397935261] transaction","detail":"{read_only:false; response_revision:5283; number_of_response:1; }","duration":"247.695033ms","start":"2026-09-08T23:04:42.90136Z","end":"2026-09-08T23:04:43.149055Z","steps":["trace[1397935261] 'process raft request' (duration: 155.359999ms)","trace[1397935261] 'compare' (duration: 92.2006ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T23:04:43.149319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.610988ms","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-09-08T23:04:43.149316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.23525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-09-08T23:04:43.149407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.046901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T23:04:43.149419Z","caller":"traceutil/trace.go:171","msg":"trace[952625645] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5283; }","duration":"230.391725ms","start":"2026-09-08T23:04:42.919002Z","end":"2026-09-08T23:04:43.149394Z","steps":["trace[952625645] 'agreement among raft nodes before linearized reading' (duration: 230.136648ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:04:43.14944Z","caller":"traceutil/trace.go:171","msg":"trace[1977416997] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:5283; }","duration":"208.081253ms","start":"2026-09-08T23:04:42.941349Z","end":"2026-09-08T23:04:43.14943Z","steps":["trace[1977416997] 'agreement among raft nodes before linearized reading' (duration: 208.030611ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:04:43.14944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.094532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5cb00884-af5a-4d1a-bf7c-543c334de9e5\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-09-08T23:04:43.149539Z","caller":"traceutil/trace.go:171","msg":"trace[1564531361] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5cb00884-af5a-4d1a-bf7c-543c334de9e5; range_end:; response_count:1; response_revision:5283; }","duration":"182.231015ms","start":"2026-09-08T23:04:42.967287Z","end":"2026-09-08T23:04:43.149518Z","steps":["trace[1564531361] 'agreement among raft nodes before linearized reading' (duration: 181.946767ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:04:43.149591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.814016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-08T23:04:43.149358Z","caller":"traceutil/trace.go:171","msg":"trace[2040481245] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5283; }","duration":"222.68554ms","start":"2026-09-08T23:04:42.926662Z","end":"2026-09-08T23:04:43.149348Z","steps":["trace[2040481245] 'agreement among raft nodes before linearized reading' (duration: 222.553266ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:04:43.149634Z","caller":"traceutil/trace.go:171","msg":"trace[206594956] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5283; }","duration":"219.871927ms","start":"2026-09-08T23:04:42.929749Z","end":"2026-09-08T23:04:43.149621Z","steps":["trace[206594956] 'agreement among raft nodes before linearized reading' (duration: 219.756304ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:04:43.14971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.399432ms","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-09-08T23:04:43.149746Z","caller":"traceutil/trace.go:171","msg":"trace[1379940658] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5283; }","duration":"220.455414ms","start":"2026-09-08T23:04:42.929282Z","end":"2026-09-08T23:04:43.149738Z","steps":["trace[1379940658] 'agreement among raft nodes before linearized reading' (duration: 220.359012ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:04:58.707178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.444598ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-08T23:04:58.70732Z","caller":"traceutil/trace.go:171","msg":"trace[1976218281] transaction","detail":"{read_only:false; response_revision:5566; number_of_response:1; }","duration":"279.561576ms","start":"2026-09-08T23:04:58.427735Z","end":"2026-09-08T23:04:58.707296Z","steps":["trace[1976218281] 'process raft request' (duration: 35.756808ms)","trace[1976218281] 'compare' (duration: 243.20917ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:04:58.711916Z","caller":"traceutil/trace.go:171","msg":"trace[250544090] transaction","detail":"{read_only:false; response_revision:5567; number_of_response:1; }","duration":"268.665906ms","start":"2026-09-08T23:04:58.443224Z","end":"2026-09-08T23:04:58.71189Z","steps":["trace[250544090] 'process raft request' (duration: 268.43258ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:04:58.711942Z","caller":"traceutil/trace.go:171","msg":"trace[1756118397] linearizableReadLoop","detail":"{readStateIndex:5777; appliedIndex:5775; }","duration":"267.295227ms","start":"2026-09-08T23:04:58.444616Z","end":"2026-09-08T23:04:58.711911Z","steps":["trace[1756118397] 'read index received' (duration: 18.826562ms)","trace[1756118397] 'applied index is now lower than readState.Index' (duration: 248.467335ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:04:58.712139Z","caller":"traceutil/trace.go:171","msg":"trace[877729190] transaction","detail":"{read_only:false; response_revision:5568; number_of_response:1; }","duration":"261.480547ms","start":"2026-09-08T23:04:58.450564Z","end":"2026-09-08T23:04:58.712045Z","steps":["trace[877729190] 'process raft request' (duration: 261.227139ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:04:58.712265Z","caller":"traceutil/trace.go:171","msg":"trace[420043545] transaction","detail":"{read_only:false; number_of_response:1; response_revision:5568; }","duration":"261.116685ms","start":"2026-09-08T23:04:58.451136Z","end":"2026-09-08T23:04:58.712252Z","steps":["trace[420043545] 'process raft request' (duration: 260.740024ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:04:58.712741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.116621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:1717"} {"level":"info","ts":"2026-09-08T23:04:58.712796Z","caller":"traceutil/trace.go:171","msg":"trace[164105813] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:5568; }","duration":"268.229344ms","start":"2026-09-08T23:04:58.444551Z","end":"2026-09-08T23:04:58.71278Z","steps":["trace[164105813] 'agreement among raft nodes before linearized reading' (duration: 267.886763ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:04:59.110961Z","caller":"traceutil/trace.go:171","msg":"trace[1608673173] transaction","detail":"{read_only:false; response_revision:5571; number_of_response:1; }","duration":"393.756109ms","start":"2026-09-08T23:04:58.717162Z","end":"2026-09-08T23:04:59.110918Z","steps":["trace[1608673173] 'process raft request' (duration: 342.292842ms)","trace[1608673173] 'compare' (duration: 51.141188ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:04:59.111054Z","caller":"traceutil/trace.go:171","msg":"trace[1613238103] transaction","detail":"{read_only:false; response_revision:5574; number_of_response:1; }","duration":"319.180286ms","start":"2026-09-08T23:04:58.791839Z","end":"2026-09-08T23:04:59.11102Z","steps":["trace[1613238103] 'process raft request' (duration: 319.114194ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:04:59.111163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:04:58.717141Z","time spent":"393.904153ms","remote":"127.0.0.1:56394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":840,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-08T23:04:59.111262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:04:58.791805Z","time spent":"319.369121ms","remote":"127.0.0.1:56406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2581,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-08T23:04:59.111291Z","caller":"traceutil/trace.go:171","msg":"trace[1498776069] transaction","detail":"{read_only:false; response_revision:5572; number_of_response:1; }","duration":"374.65322ms","start":"2026-09-08T23:04:58.736606Z","end":"2026-09-08T23:04:59.111259Z","steps":["trace[1498776069] 'process raft request' (duration: 374.212757ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:04:59.111306Z","caller":"traceutil/trace.go:171","msg":"trace[865818470] transaction","detail":"{read_only:false; response_revision:5573; number_of_response:1; }","duration":"371.794156ms","start":"2026-09-08T23:04:58.73947Z","end":"2026-09-08T23:04:59.111264Z","steps":["trace[865818470] 'process raft request' (duration: 371.424955ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:04:59.111446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:04:58.736591Z","time spent":"374.774963ms","remote":"127.0.0.1:56562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T23:04:59.111478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:04:58.739459Z","time spent":"371.925719ms","remote":"127.0.0.1:37454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2250,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T23:05:07.430622Z","caller":"traceutil/trace.go:171","msg":"trace[712557344] linearizableReadLoop","detail":"{readStateIndex:5973; appliedIndex:5972; }","duration":"105.248772ms","start":"2026-09-08T23:05:07.325339Z","end":"2026-09-08T23:05:07.430588Z","steps":["trace[712557344] 'read index received' (duration: 92.89701ms)","trace[712557344] 'applied index is now lower than readState.Index' (duration: 12.349852ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:05:07.430708Z","caller":"traceutil/trace.go:171","msg":"trace[2116584333] transaction","detail":"{read_only:false; response_revision:5758; number_of_response:1; }","duration":"105.380286ms","start":"2026-09-08T23:05:07.325278Z","end":"2026-09-08T23:05:07.430658Z","steps":["trace[2116584333] 'process raft request' (duration: 92.812058ms)","trace[2116584333] 'compare' (duration: 12.310761ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T23:05:07.430963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.580761ms","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-09-08T23:05:07.431013Z","caller":"traceutil/trace.go:171","msg":"trace[502185940] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5758; }","duration":"105.683645ms","start":"2026-09-08T23:05:07.325313Z","end":"2026-09-08T23:05:07.430997Z","steps":["trace[502185940] 'agreement among raft nodes before linearized reading' (duration: 105.447028ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:05:07.448383Z","caller":"traceutil/trace.go:171","msg":"trace[345340645] transaction","detail":"{read_only:false; response_revision:5759; number_of_response:1; }","duration":"122.045443ms","start":"2026-09-08T23:05:07.326308Z","end":"2026-09-08T23:05:07.448354Z","steps":["trace[345340645] 'process raft request' (duration: 121.61436ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:05:07.448452Z","caller":"traceutil/trace.go:171","msg":"trace[352969235] transaction","detail":"{read_only:false; response_revision:5760; number_of_response:1; }","duration":"120.688013ms","start":"2026-09-08T23:05:07.327742Z","end":"2026-09-08T23:05:07.44843Z","steps":["trace[352969235] 'process raft request' (duration: 120.425426ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:05:07.448603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.479758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-08T23:05:07.448719Z","caller":"traceutil/trace.go:171","msg":"trace[678294285] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5760; }","duration":"119.672185ms","start":"2026-09-08T23:05:07.329019Z","end":"2026-09-08T23:05:07.448691Z","steps":["trace[678294285] 'agreement among raft nodes before linearized reading' (duration: 119.235112ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:05:07.761215Z","caller":"traceutil/trace.go:171","msg":"trace[1227503986] transaction","detail":"{read_only:false; response_revision:5763; number_of_response:1; }","duration":"269.877772ms","start":"2026-09-08T23:05:07.491291Z","end":"2026-09-08T23:05:07.761168Z","steps":["trace[1227503986] 'process raft request' (duration: 231.945072ms)","trace[1227503986] 'compare' (duration: 37.678403ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:05:07.815028Z","caller":"traceutil/trace.go:171","msg":"trace[648296449] linearizableReadLoop","detail":"{readStateIndex:5979; appliedIndex:5977; }","duration":"116.583654ms","start":"2026-09-08T23:05:07.698407Z","end":"2026-09-08T23:05:07.814991Z","steps":["trace[648296449] 'read index received' (duration: 24.869009ms)","trace[648296449] 'applied index is now lower than readState.Index' (duration: 91.713025ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:05:07.815085Z","caller":"traceutil/trace.go:171","msg":"trace[1912161606] transaction","detail":"{read_only:false; response_revision:5764; number_of_response:1; }","duration":"224.542065ms","start":"2026-09-08T23:05:07.590505Z","end":"2026-09-08T23:05:07.815047Z","steps":["trace[1912161606] 'process raft request' (duration: 224.305617ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:05:07.815276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.827551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T23:05:07.815422Z","caller":"traceutil/trace.go:171","msg":"trace[268381059] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:5764; }","duration":"117.033437ms","start":"2026-09-08T23:05:07.698363Z","end":"2026-09-08T23:05:07.815397Z","steps":["trace[268381059] 'agreement among raft nodes before linearized reading' (duration: 116.80263ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:05:07.844142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.220739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-08T23:05:07.844207Z","caller":"traceutil/trace.go:171","msg":"trace[1720472397] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:5767; }","duration":"108.383263ms","start":"2026-09-08T23:05:07.735808Z","end":"2026-09-08T23:05:07.844191Z","steps":["trace[1720472397] 'agreement among raft nodes before linearized reading' (duration: 108.229518ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:05:13.61414Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2959} {"level":"info","ts":"2026-09-08T23:05:13.692279Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2959,"took":"76.353565ms","hash":3490501847,"current-db-size-bytes":56299520,"current-db-size":"56 MB","current-db-size-in-use-bytes":32382976,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-08T23:05:13.692366Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3490501847,"revision":2959,"compact-revision":-1} {"level":"warn","ts":"2026-09-08T23:08:10.648522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.108702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-09-08T23:08:10.648616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.835312ms","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-09-08T23:08:10.64867Z","caller":"traceutil/trace.go:171","msg":"trace[538339345] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7056; }","duration":"112.305597ms","start":"2026-09-08T23:08:10.536332Z","end":"2026-09-08T23:08:10.648638Z","steps":["trace[538339345] 'range keys from in-memory index tree' (duration: 111.893726ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:08:10.648698Z","caller":"traceutil/trace.go:171","msg":"trace[843781638] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7056; }","duration":"112.949435ms","start":"2026-09-08T23:08:10.53573Z","end":"2026-09-08T23:08:10.648679Z","steps":["trace[843781638] 'range keys from in-memory index tree' (duration: 112.726699ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:08:10.648766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.908162ms","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-09-08T23:08:10.648827Z","caller":"traceutil/trace.go:171","msg":"trace[1448611154] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7056; }","duration":"156.011756ms","start":"2026-09-08T23:08:10.492799Z","end":"2026-09-08T23:08:10.648811Z","steps":["trace[1448611154] 'range keys from in-memory index tree' (duration: 155.754259ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:08:10.648812Z","caller":"traceutil/trace.go:171","msg":"trace[479563071] transaction","detail":"{read_only:false; response_revision:7057; number_of_response:1; }","duration":"103.795178ms","start":"2026-09-08T23:08:10.54498Z","end":"2026-09-08T23:08:10.648775Z","steps":["trace[479563071] 'process raft request' (duration: 101.836141ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:08:10.742785Z","caller":"traceutil/trace.go:171","msg":"trace[118113081] transaction","detail":"{read_only:false; response_revision:7058; number_of_response:1; }","duration":"168.002467ms","start":"2026-09-08T23:08:10.574759Z","end":"2026-09-08T23:08:10.742761Z","steps":["trace[118113081] 'process raft request' (duration: 167.868533ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:08:10.77119Z","caller":"traceutil/trace.go:171","msg":"trace[330529701] transaction","detail":"{read_only:false; response_revision:7059; number_of_response:1; }","duration":"117.812408ms","start":"2026-09-08T23:08:10.653344Z","end":"2026-09-08T23:08:10.771156Z","steps":["trace[330529701] 'process raft request' (duration: 114.026477ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:08:10.771176Z","caller":"traceutil/trace.go:171","msg":"trace[999214473] transaction","detail":"{read_only:false; response_revision:7060; number_of_response:1; }","duration":"117.503679ms","start":"2026-09-08T23:08:10.653641Z","end":"2026-09-08T23:08:10.771144Z","steps":["trace[999214473] 'process raft request' (duration: 117.391086ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:08:10.771228Z","caller":"traceutil/trace.go:171","msg":"trace[1127450053] transaction","detail":"{read_only:false; response_revision:7061; number_of_response:1; }","duration":"117.505129ms","start":"2026-09-08T23:08:10.653702Z","end":"2026-09-08T23:08:10.771207Z","steps":["trace[1127450053] 'process raft request' (duration: 117.379236ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:10:13.621917Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5858} {"level":"info","ts":"2026-09-08T23:10:13.723925Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5858,"took":"100.179285ms","hash":3230467638,"current-db-size-bytes":56299520,"current-db-size":"56 MB","current-db-size-in-use-bytes":26591232,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-08T23:10:13.724009Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3230467638,"revision":5858,"compact-revision":2959} {"level":"info","ts":"2026-09-08T23:11:17.073792Z","caller":"traceutil/trace.go:171","msg":"trace[613446554] transaction","detail":"{read_only:false; response_revision:8581; number_of_response:1; }","duration":"384.368161ms","start":"2026-09-08T23:11:16.689397Z","end":"2026-09-08T23:11:17.073765Z","steps":["trace[613446554] 'process raft request' (duration: 384.163255ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:11:17.074004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:11:16.689345Z","time spent":"384.546736ms","remote":"127.0.0.1:56562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T23:11:17.297384Z","caller":"traceutil/trace.go:171","msg":"trace[656847442] transaction","detail":"{read_only:false; response_revision:8582; number_of_response:1; }","duration":"516.176383ms","start":"2026-09-08T23:11:16.781181Z","end":"2026-09-08T23:11:17.297357Z","steps":["trace[656847442] 'process raft request' (duration: 515.894043ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:11:17.297389Z","caller":"traceutil/trace.go:171","msg":"trace[1105148952] linearizableReadLoop","detail":"{readStateIndex:8886; appliedIndex:8885; }","duration":"120.488099ms","start":"2026-09-08T23:11:17.176862Z","end":"2026-09-08T23:11:17.29735Z","steps":["trace[1105148952] 'read index received' (duration: 120.104457ms)","trace[1105148952] 'applied index is now lower than readState.Index' (duration: 382.062µs)"],"step_count":2} {"level":"warn","ts":"2026-09-08T23:11:17.297546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:11:16.78115Z","time spent":"516.296826ms","remote":"127.0.0.1:56562","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-09-08T23:11:17.297654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.774537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-08T23:11:17.297751Z","caller":"traceutil/trace.go:171","msg":"trace[1602756840] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8582; }","duration":"120.927862ms","start":"2026-09-08T23:11:17.1768Z","end":"2026-09-08T23:11:17.297728Z","steps":["trace[1602756840] 'agreement among raft nodes before linearized reading' (duration: 120.694455ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:11:17.297794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.284471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.82\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-09-08T23:11:17.297903Z","caller":"traceutil/trace.go:171","msg":"trace[622068045] range","detail":"{range_begin:/registry/masterleases/162.253.55.82; range_end:; response_count:1; response_revision:8582; }","duration":"110.458815ms","start":"2026-09-08T23:11:17.187421Z","end":"2026-09-08T23:11:17.297879Z","steps":["trace[622068045] 'agreement among raft nodes before linearized reading' (duration: 110.175557ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:11:29.763028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.949998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-08T23:11:29.763047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.486403ms","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-09-08T23:11:29.763152Z","caller":"traceutil/trace.go:171","msg":"trace[637456944] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8649; }","duration":"200.154004ms","start":"2026-09-08T23:11:29.562975Z","end":"2026-09-08T23:11:29.763129Z","steps":["trace[637456944] 'count revisions from in-memory index tree' (duration: 199.851735ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:11:29.763201Z","caller":"traceutil/trace.go:171","msg":"trace[1771715804] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8649; }","duration":"231.686158ms","start":"2026-09-08T23:11:29.531462Z","end":"2026-09-08T23:11:29.763148Z","steps":["trace[1771715804] 'range keys from in-memory index tree' (duration: 231.263585ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:11:30.563212Z","caller":"traceutil/trace.go:171","msg":"trace[1725488792] transaction","detail":"{read_only:false; response_revision:8654; number_of_response:1; }","duration":"171.300278ms","start":"2026-09-08T23:11:30.39184Z","end":"2026-09-08T23:11:30.56314Z","steps":["trace[1725488792] 'process raft request' (duration: 171.064992ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:11:58.961347Z","caller":"traceutil/trace.go:171","msg":"trace[1951949615] transaction","detail":"{read_only:false; response_revision:8861; number_of_response:1; }","duration":"204.877619ms","start":"2026-09-08T23:11:58.756438Z","end":"2026-09-08T23:11:58.961316Z","steps":["trace[1951949615] 'process raft request' (duration: 204.678172ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:12:06.297541Z","caller":"traceutil/trace.go:171","msg":"trace[1718988543] transaction","detail":"{read_only:false; response_revision:8902; number_of_response:1; }","duration":"102.269554ms","start":"2026-09-08T23:12:06.195243Z","end":"2026-09-08T23:12:06.297513Z","steps":["trace[1718988543] 'process raft request' (duration: 102.11521ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:12:06.366118Z","caller":"traceutil/trace.go:171","msg":"trace[1007205694] transaction","detail":"{read_only:false; response_revision:8903; number_of_response:1; }","duration":"170.829432ms","start":"2026-09-08T23:12:06.195254Z","end":"2026-09-08T23:12:06.366083Z","steps":["trace[1007205694] 'process raft request' (duration: 170.634576ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:12:06.366277Z","caller":"traceutil/trace.go:171","msg":"trace[1742113196] linearizableReadLoop","detail":"{readStateIndex:9221; appliedIndex:9218; }","duration":"145.723127ms","start":"2026-09-08T23:12:06.220504Z","end":"2026-09-08T23:12:06.366227Z","steps":["trace[1742113196] 'read index received' (duration: 76.939273ms)","trace[1742113196] 'applied index is now lower than readState.Index' (duration: 68.781774ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:12:06.366393Z","caller":"traceutil/trace.go:171","msg":"trace[1311931430] transaction","detail":"{read_only:false; response_revision:8904; number_of_response:1; }","duration":"169.734149ms","start":"2026-09-08T23:12:06.196647Z","end":"2026-09-08T23:12:06.366382Z","steps":["trace[1311931430] 'process raft request' (duration: 169.392879ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:12:06.366449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.913192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T23:12:06.366488Z","caller":"traceutil/trace.go:171","msg":"trace[85743815] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8904; }","duration":"146.009145ms","start":"2026-09-08T23:12:06.220468Z","end":"2026-09-08T23:12:06.366477Z","steps":["trace[85743815] 'agreement among raft nodes before linearized reading' (duration: 145.903772ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:12:07.226804Z","caller":"traceutil/trace.go:171","msg":"trace[1226975877] linearizableReadLoop","detail":"{readStateIndex:9222; appliedIndex:9221; }","duration":"213.884082ms","start":"2026-09-08T23:12:07.012892Z","end":"2026-09-08T23:12:07.226776Z","steps":["trace[1226975877] 'read index received' (duration: 213.694627ms)","trace[1226975877] 'applied index is now lower than readState.Index' (duration: 188.915µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:12:07.226887Z","caller":"traceutil/trace.go:171","msg":"trace[1989152031] transaction","detail":"{read_only:false; response_revision:8905; number_of_response:1; }","duration":"229.079197ms","start":"2026-09-08T23:12:06.997774Z","end":"2026-09-08T23:12:07.226853Z","steps":["trace[1989152031] 'process raft request' (duration: 228.865701ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:12:07.226968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.457701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-08T23:12:07.226992Z","caller":"traceutil/trace.go:171","msg":"trace[650485078] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:8905; }","duration":"143.557833ms","start":"2026-09-08T23:12:07.083427Z","end":"2026-09-08T23:12:07.226985Z","steps":["trace[650485078] 'agreement among raft nodes before linearized reading' (duration: 143.479961ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:12:07.227005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.081318ms","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:5"} {"level":"info","ts":"2026-09-08T23:12:07.227102Z","caller":"traceutil/trace.go:171","msg":"trace[1979013523] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:8905; }","duration":"214.238872ms","start":"2026-09-08T23:12:07.012841Z","end":"2026-09-08T23:12:07.22708Z","steps":["trace[1979013523] 'agreement among raft nodes before linearized reading' (duration: 214.061377ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:12:07.227091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.954308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T23:12:07.227194Z","caller":"traceutil/trace.go:171","msg":"trace[918589963] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:8905; }","duration":"139.085181ms","start":"2026-09-08T23:12:07.088086Z","end":"2026-09-08T23:12:07.227171Z","steps":["trace[918589963] 'agreement among raft nodes before linearized reading' (duration: 138.935247ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:12:07.227239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.829547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-08T23:12:07.227376Z","caller":"traceutil/trace.go:171","msg":"trace[13727024] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:8905; }","duration":"122.032953ms","start":"2026-09-08T23:12:07.105317Z","end":"2026-09-08T23:12:07.22735Z","steps":["trace[13727024] 'agreement among raft nodes before linearized reading' (duration: 121.717534ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:12:12.228911Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000242b.wal"} {"level":"info","ts":"2026-09-08T23:12:12.799535Z","caller":"traceutil/trace.go:171","msg":"trace[584262142] linearizableReadLoop","detail":"{readStateIndex:9280; appliedIndex:9279; }","duration":"297.003695ms","start":"2026-09-08T23:12:12.502496Z","end":"2026-09-08T23:12:12.7995Z","steps":["trace[584262142] 'read index received' (duration: 296.715907ms)","trace[584262142] 'applied index is now lower than readState.Index' (duration: 286.758µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:12:12.799674Z","caller":"traceutil/trace.go:171","msg":"trace[1780706309] transaction","detail":"{read_only:false; response_revision:8959; number_of_response:1; }","duration":"298.52695ms","start":"2026-09-08T23:12:12.501111Z","end":"2026-09-08T23:12:12.799638Z","steps":["trace[1780706309] 'process raft request' (duration: 298.164709ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:12:12.80001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.473089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-09-08T23:12:12.800108Z","caller":"traceutil/trace.go:171","msg":"trace[1070428019] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:8959; }","duration":"297.601962ms","start":"2026-09-08T23:12:12.50248Z","end":"2026-09-08T23:12:12.800082Z","steps":["trace[1070428019] 'agreement among raft nodes before linearized reading' (duration: 297.270233ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:12:12.800061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.326395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-8b9t2\" ","response":"range_response_count:1 size:4652"} {"level":"info","ts":"2026-09-08T23:12:12.800322Z","caller":"traceutil/trace.go:171","msg":"trace[887529918] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-8b9t2; range_end:; response_count:1; response_revision:8959; }","duration":"297.625803ms","start":"2026-09-08T23:12:12.502675Z","end":"2026-09-08T23:12:12.800301Z","steps":["trace[887529918] 'agreement among raft nodes before linearized reading' (duration: 297.18727ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:12:12.934895Z","caller":"traceutil/trace.go:171","msg":"trace[84699428] linearizableReadLoop","detail":"{readStateIndex:9281; appliedIndex:9280; }","duration":"126.004479ms","start":"2026-09-08T23:12:12.808862Z","end":"2026-09-08T23:12:12.934866Z","steps":["trace[84699428] 'read index received' (duration: 27.301629ms)","trace[84699428] 'applied index is now lower than readState.Index' (duration: 98.70178ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:12:12.934994Z","caller":"traceutil/trace.go:171","msg":"trace[267710516] transaction","detail":"{read_only:false; response_revision:8960; number_of_response:1; }","duration":"127.167663ms","start":"2026-09-08T23:12:12.807818Z","end":"2026-09-08T23:12:12.934985Z","steps":["trace[267710516] 'process raft request' (duration: 28.34347ms)","trace[267710516] 'compare' (duration: 98.604497ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T23:12:12.935257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.361609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-09-08T23:12:12.935376Z","caller":"traceutil/trace.go:171","msg":"trace[1083898563] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:8960; }","duration":"126.523364ms","start":"2026-09-08T23:12:12.808806Z","end":"2026-09-08T23:12:12.935329Z","steps":["trace[1083898563] 'agreement among raft nodes before linearized reading' (duration: 126.195845ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:12:13.084268Z","caller":"traceutil/trace.go:171","msg":"trace[1694245309] transaction","detail":"{read_only:false; response_revision:8961; number_of_response:1; }","duration":"274.485616ms","start":"2026-09-08T23:12:12.809736Z","end":"2026-09-08T23:12:13.084221Z","steps":["trace[1694245309] 'process raft request' (duration: 274.192898ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:12:13.084369Z","caller":"traceutil/trace.go:171","msg":"trace[2008216747] transaction","detail":"{read_only:false; response_revision:8963; number_of_response:1; }","duration":"274.415384ms","start":"2026-09-08T23:12:12.809893Z","end":"2026-09-08T23:12:13.084309Z","steps":["trace[2008216747] 'process raft request' (duration: 274.237839ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:12:13.08439Z","caller":"traceutil/trace.go:171","msg":"trace[1755475064] linearizableReadLoop","detail":"{readStateIndex:9287; appliedIndex:9281; }","duration":"149.378962ms","start":"2026-09-08T23:12:12.934957Z","end":"2026-09-08T23:12:13.084336Z","steps":["trace[1755475064] 'read index received' (duration: 148.880028ms)","trace[1755475064] 'applied index is now lower than readState.Index' (duration: 497.294µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:12:13.084398Z","caller":"traceutil/trace.go:171","msg":"trace[331637437] transaction","detail":"{read_only:false; response_revision:8962; number_of_response:1; }","duration":"274.482996ms","start":"2026-09-08T23:12:12.809855Z","end":"2026-09-08T23:12:13.084338Z","steps":["trace[331637437] 'process raft request' (duration: 274.228189ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:12:13.084547Z","caller":"traceutil/trace.go:171","msg":"trace[769765139] transaction","detail":"{read_only:false; response_revision:8964; number_of_response:1; }","duration":"274.566458ms","start":"2026-09-08T23:12:12.809954Z","end":"2026-09-08T23:12:13.08452Z","steps":["trace[769765139] 'process raft request' (duration: 274.206578ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:12:13.084609Z","caller":"traceutil/trace.go:171","msg":"trace[465944846] transaction","detail":"{read_only:false; response_revision:8966; number_of_response:1; }","duration":"263.360412ms","start":"2026-09-08T23:12:12.821236Z","end":"2026-09-08T23:12:13.084596Z","steps":["trace[465944846] 'process raft request' (duration: 263.015151ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:12:13.084707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.112596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-r6flk\" ","response":"range_response_count:1 size:6526"} {"level":"info","ts":"2026-09-08T23:12:13.084758Z","caller":"traceutil/trace.go:171","msg":"trace[252841426] range","detail":"{range_begin:/registry/pods/openstack/keepalived-r6flk; range_end:; response_count:1; response_revision:8966; }","duration":"245.22689ms","start":"2026-09-08T23:12:12.839519Z","end":"2026-09-08T23:12:13.084746Z","steps":["trace[252841426] 'agreement among raft nodes before linearized reading' (duration: 245.015883ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:12:13.084926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.693842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"warn","ts":"2026-09-08T23:12:13.085057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.001016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-09-08T23:12:13.085111Z","caller":"traceutil/trace.go:171","msg":"trace[1394214357] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:8966; }","duration":"145.125159ms","start":"2026-09-08T23:12:12.939971Z","end":"2026-09-08T23:12:13.085097Z","steps":["trace[1394214357] 'agreement among raft nodes before linearized reading' (duration: 144.669586ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:12:13.085161Z","caller":"traceutil/trace.go:171","msg":"trace[428086722] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:8966; }","duration":"233.945449ms","start":"2026-09-08T23:12:12.851121Z","end":"2026-09-08T23:12:13.085066Z","steps":["trace[428086722] 'agreement among raft nodes before linearized reading' (duration: 233.411343ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:12:13.084947Z","caller":"traceutil/trace.go:171","msg":"trace[597067827] transaction","detail":"{read_only:false; response_revision:8965; number_of_response:1; }","duration":"274.783605ms","start":"2026-09-08T23:12:12.809947Z","end":"2026-09-08T23:12:13.084731Z","steps":["trace[597067827] 'process raft request' (duration: 274.255019ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:12:13.214272Z","caller":"traceutil/trace.go:171","msg":"trace[1540305381] transaction","detail":"{read_only:false; response_revision:8968; number_of_response:1; }","duration":"121.501358ms","start":"2026-09-08T23:12:13.092737Z","end":"2026-09-08T23:12:13.214238Z","steps":["trace[1540305381] 'process raft request' (duration: 111.395122ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:12:13.214398Z","caller":"traceutil/trace.go:171","msg":"trace[736221525] transaction","detail":"{read_only:false; response_revision:8969; number_of_response:1; }","duration":"105.113708ms","start":"2026-09-08T23:12:13.109223Z","end":"2026-09-08T23:12:13.214337Z","steps":["trace[736221525] 'process raft request' (duration: 104.928482ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:12:13.214425Z","caller":"traceutil/trace.go:171","msg":"trace[955111373] linearizableReadLoop","detail":"{readStateIndex:9289; appliedIndex:9287; }","duration":"119.172009ms","start":"2026-09-08T23:12:13.09521Z","end":"2026-09-08T23:12:13.214382Z","steps":["trace[955111373] 'read index received' (duration: 59.663747ms)","trace[955111373] 'applied index is now lower than readState.Index' (duration: 59.500062ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T23:12:13.217861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.61685ms","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-09-08T23:12:13.217914Z","caller":"traceutil/trace.go:171","msg":"trace[757880774] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:8970; }","duration":"122.717153ms","start":"2026-09-08T23:12:13.095184Z","end":"2026-09-08T23:12:13.217901Z","steps":["trace[757880774] 'agreement among raft nodes before linearized reading' (duration: 122.467826ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:12:13.288661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.619331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-8b9t2\" ","response":"range_response_count:1 size:4652"} {"level":"info","ts":"2026-09-08T23:12:13.288755Z","caller":"traceutil/trace.go:171","msg":"trace[1821518733] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-8b9t2; range_end:; response_count:1; response_revision:8971; }","duration":"105.791056ms","start":"2026-09-08T23:12:13.182944Z","end":"2026-09-08T23:12:13.288735Z","steps":["trace[1821518733] 'agreement among raft nodes before linearized reading' (duration: 105.57254ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:12:13.288781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.357068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3684"} {"level":"info","ts":"2026-09-08T23:12:13.288841Z","caller":"traceutil/trace.go:171","msg":"trace[1453304166] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:8971; }","duration":"154.479752ms","start":"2026-09-08T23:12:13.134345Z","end":"2026-09-08T23:12:13.288825Z","steps":["trace[1453304166] 'agreement among raft nodes before linearized reading' (duration: 154.333418ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:12:13.289557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.402553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228434"} {"level":"info","ts":"2026-09-08T23:12:13.289602Z","caller":"traceutil/trace.go:171","msg":"trace[1057299066] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8971; }","duration":"191.471406ms","start":"2026-09-08T23:12:13.09812Z","end":"2026-09-08T23:12:13.289592Z","steps":["trace[1057299066] 'agreement among raft nodes before linearized reading' (duration: 191.082995ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:12:25.475228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.918282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228626"} {"level":"info","ts":"2026-09-08T23:12:25.475339Z","caller":"traceutil/trace.go:171","msg":"trace[112107277] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:9078; }","duration":"103.064938ms","start":"2026-09-08T23:12:25.372255Z","end":"2026-09-08T23:12:25.47532Z","steps":["trace[112107277] 'range keys from in-memory index tree' (duration: 102.552132ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:13:18.533791Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c5298098e2dc0f92","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-08T23:13:18.543833Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-09-08T23:13:18.543993Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-09-08T23:13:36.297137Z","caller":"traceutil/trace.go:171","msg":"trace[1275077305] transaction","detail":"{read_only:false; response_revision:9766; number_of_response:1; }","duration":"127.855544ms","start":"2026-09-08T23:13:36.169234Z","end":"2026-09-08T23:13:36.297089Z","steps":["trace[1275077305] 'process raft request' (duration: 108.959681ms)","trace[1275077305] 'compare' (duration: 18.713538ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:15:13.629735Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8016} {"level":"info","ts":"2026-09-08T23:15:13.701067Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8016,"took":"69.197106ms","hash":449036788,"current-db-size-bytes":56299520,"current-db-size":"56 MB","current-db-size-in-use-bytes":28831744,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-09-08T23:15:13.701153Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":449036788,"revision":8016,"compact-revision":5858} {"level":"info","ts":"2026-09-08T23:20:13.637628Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10446} {"level":"info","ts":"2026-09-08T23:20:13.72596Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10446,"took":"85.631486ms","hash":2685882969,"current-db-size-bytes":56299520,"current-db-size":"56 MB","current-db-size-in-use-bytes":27709440,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-08T23:20:13.726035Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2685882969,"revision":10446,"compact-revision":8016} {"level":"info","ts":"2026-09-08T23:23:38.184802Z","caller":"traceutil/trace.go:171","msg":"trace[633745472] transaction","detail":"{read_only:false; response_revision:14160; number_of_response:1; }","duration":"124.38371ms","start":"2026-09-08T23:23:38.060389Z","end":"2026-09-08T23:23:38.184773Z","steps":["trace[633745472] 'process raft request' (duration: 124.138223ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:23:48.439723Z","caller":"traceutil/trace.go:171","msg":"trace[2072852621] transaction","detail":"{read_only:false; response_revision:14213; number_of_response:1; }","duration":"135.763933ms","start":"2026-09-08T23:23:48.303927Z","end":"2026-09-08T23:23:48.439691Z","steps":["trace[2072852621] 'process raft request' (duration: 135.637859ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:23:48.439753Z","caller":"traceutil/trace.go:171","msg":"trace[1253045953] transaction","detail":"{read_only:false; response_revision:14212; number_of_response:1; }","duration":"138.981936ms","start":"2026-09-08T23:23:48.30073Z","end":"2026-09-08T23:23:48.439712Z","steps":["trace[1253045953] 'process raft request' (duration: 122.02885ms)","trace[1253045953] 'compare' (duration: 16.550045ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:23:48.439885Z","caller":"traceutil/trace.go:171","msg":"trace[251142359] transaction","detail":"{read_only:false; response_revision:14214; number_of_response:1; }","duration":"114.54805ms","start":"2026-09-08T23:23:48.325304Z","end":"2026-09-08T23:23:48.439852Z","steps":["trace[251142359] 'process raft request' (duration: 114.347825ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:23:56.76604Z","caller":"traceutil/trace.go:171","msg":"trace[2117321109] transaction","detail":"{read_only:false; response_revision:14269; number_of_response:1; }","duration":"291.506049ms","start":"2026-09-08T23:23:56.474493Z","end":"2026-09-08T23:23:56.765999Z","steps":["trace[2117321109] 'process raft request' (duration: 291.261462ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:23:56.959631Z","caller":"traceutil/trace.go:171","msg":"trace[845887299] transaction","detail":"{read_only:false; response_revision:14270; number_of_response:1; }","duration":"483.789224ms","start":"2026-09-08T23:23:56.475786Z","end":"2026-09-08T23:23:56.959576Z","steps":["trace[845887299] 'process raft request' (duration: 482.027913ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:23:56.959798Z","caller":"traceutil/trace.go:171","msg":"trace[819311365] linearizableReadLoop","detail":"{readStateIndex:14766; appliedIndex:14763; }","duration":"477.695697ms","start":"2026-09-08T23:23:56.482069Z","end":"2026-09-08T23:23:56.959765Z","steps":["trace[819311365] 'read index received' (duration: 283.66048ms)","trace[819311365] 'applied index is now lower than readState.Index' (duration: 194.032587ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T23:23:56.959853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:23:56.475754Z","time spent":"483.9721ms","remote":"127.0.0.1:56562","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-09-08T23:23:56.959947Z","caller":"traceutil/trace.go:171","msg":"trace[1131857394] transaction","detail":"{read_only:false; response_revision:14271; number_of_response:1; }","duration":"480.706206ms","start":"2026-09-08T23:23:56.479224Z","end":"2026-09-08T23:23:56.95993Z","steps":["trace[1131857394] 'process raft request' (duration: 480.291323ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:23:56.960047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:23:56.479212Z","time spent":"480.777057ms","remote":"127.0.0.1:56562","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-09-08T23:23:56.960152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.085518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-09-08T23:23:56.960201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.020076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:356"} {"level":"info","ts":"2026-09-08T23:23:56.960246Z","caller":"traceutil/trace.go:171","msg":"trace[1295712633] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14271; }","duration":"478.215092ms","start":"2026-09-08T23:23:56.482014Z","end":"2026-09-08T23:23:56.960229Z","steps":["trace[1295712633] 'agreement among raft nodes before linearized reading' (duration: 477.974405ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:23:56.96028Z","caller":"traceutil/trace.go:171","msg":"trace[1852224159] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:14271; }","duration":"262.186061ms","start":"2026-09-08T23:23:56.698072Z","end":"2026-09-08T23:23:56.960258Z","steps":["trace[1852224159] 'agreement among raft nodes before linearized reading' (duration: 261.930704ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:23:56.960292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:23:56.481997Z","time spent":"478.282865ms","remote":"127.0.0.1:56562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-08T23:23:56.960283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.403251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-09-08T23:23:56.960384Z","caller":"traceutil/trace.go:171","msg":"trace[797202636] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14271; }","duration":"366.586116ms","start":"2026-09-08T23:23:56.593772Z","end":"2026-09-08T23:23:56.960358Z","steps":["trace[797202636] 'agreement among raft nodes before linearized reading' (duration: 366.227486ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:23:56.960439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:23:56.593749Z","time spent":"366.676259ms","remote":"127.0.0.1:56484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-09-08T23:24:21.041083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.381024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fb1bbab7-cb7f-4987-b8a9-a5a17b946097\" ","response":"range_response_count:1 size:3636"} {"level":"info","ts":"2026-09-08T23:24:21.041177Z","caller":"traceutil/trace.go:171","msg":"trace[1553649221] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fb1bbab7-cb7f-4987-b8a9-a5a17b946097; range_end:; response_count:1; response_revision:14585; }","duration":"117.537189ms","start":"2026-09-08T23:24:20.923619Z","end":"2026-09-08T23:24:21.041156Z","steps":["trace[1553649221] 'range keys from in-memory index tree' (duration: 117.195118ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:24:21.568324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.62335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T23:24:21.568415Z","caller":"traceutil/trace.go:171","msg":"trace[811187167] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14588; }","duration":"347.778664ms","start":"2026-09-08T23:24:21.220616Z","end":"2026-09-08T23:24:21.568395Z","steps":["trace[811187167] 'range keys from in-memory index tree' (duration: 347.539468ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:24:21.568456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:24:21.220597Z","time spent":"347.849717ms","remote":"127.0.0.1:56310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-08T23:24:21.56881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.266766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-08T23:24:21.56891Z","caller":"traceutil/trace.go:171","msg":"trace[706046424] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:14588; }","duration":"379.431232ms","start":"2026-09-08T23:24:21.189439Z","end":"2026-09-08T23:24:21.56887Z","steps":["trace[706046424] 'count revisions from in-memory index tree' (duration: 379.140182ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:24:21.568839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.731423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fb1bbab7-cb7f-4987-b8a9-a5a17b946097\" ","response":"range_response_count:1 size:3636"} {"level":"warn","ts":"2026-09-08T23:24:21.568967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:24:21.189417Z","time spent":"379.535594ms","remote":"127.0.0.1:56632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":102,"response size":31,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"info","ts":"2026-09-08T23:24:21.56902Z","caller":"traceutil/trace.go:171","msg":"trace[1954954753] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fb1bbab7-cb7f-4987-b8a9-a5a17b946097; range_end:; response_count:1; response_revision:14588; }","duration":"175.333191ms","start":"2026-09-08T23:24:21.393665Z","end":"2026-09-08T23:24:21.568998Z","steps":["trace[1954954753] 'range keys from in-memory index tree' (duration: 174.513905ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:24:21.568438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.918022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T23:24:21.569176Z","caller":"traceutil/trace.go:171","msg":"trace[796348042] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:14588; }","duration":"101.677685ms","start":"2026-09-08T23:24:21.467439Z","end":"2026-09-08T23:24:21.569117Z","steps":["trace[796348042] 'count revisions from in-memory index tree' (duration: 100.792509ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:25:13.645713Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12765} {"level":"info","ts":"2026-09-08T23:25:13.733043Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12765,"took":"84.06955ms","hash":1561842752,"current-db-size-bytes":56299520,"current-db-size":"56 MB","current-db-size-in-use-bytes":30666752,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-08T23:25:13.733159Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1561842752,"revision":12765,"compact-revision":10446} {"level":"info","ts":"2026-09-08T23:25:48.330705Z","caller":"traceutil/trace.go:171","msg":"trace[425586056] linearizableReadLoop","detail":"{readStateIndex:15936; appliedIndex:15935; }","duration":"115.993984ms","start":"2026-09-08T23:25:48.214686Z","end":"2026-09-08T23:25:48.33068Z","steps":["trace[425586056] 'read index received' (duration: 115.781598ms)","trace[425586056] 'applied index is now lower than readState.Index' (duration: 211.086µs)"],"step_count":2} {"level":"warn","ts":"2026-09-08T23:25:48.33091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.229331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-09-08T23:25:48.330956Z","caller":"traceutil/trace.go:171","msg":"trace[1927222294] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15404; }","duration":"116.313444ms","start":"2026-09-08T23:25:48.214627Z","end":"2026-09-08T23:25:48.33094Z","steps":["trace[1927222294] 'agreement among raft nodes before linearized reading' (duration: 116.161749ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:25:48.330992Z","caller":"traceutil/trace.go:171","msg":"trace[457016399] transaction","detail":"{read_only:false; response_revision:15404; number_of_response:1; }","duration":"117.432486ms","start":"2026-09-08T23:25:48.21353Z","end":"2026-09-08T23:25:48.330962Z","steps":["trace[457016399] 'process raft request' (duration: 117.013094ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:25:48.532967Z","caller":"traceutil/trace.go:171","msg":"trace[1572141942] transaction","detail":"{read_only:false; response_revision:15405; number_of_response:1; }","duration":"105.906698ms","start":"2026-09-08T23:25:48.427032Z","end":"2026-09-08T23:25:48.532938Z","steps":["trace[1572141942] 'process raft request' (duration: 105.543948ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:25:48.744812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.500189ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-08T23:25:48.744928Z","caller":"traceutil/trace.go:171","msg":"trace[590323138] linearizableReadLoop","detail":"{readStateIndex:15938; appliedIndex:15937; }","duration":"203.715931ms","start":"2026-09-08T23:25:48.541187Z","end":"2026-09-08T23:25:48.744903Z","steps":["trace[590323138] 'read index received' (duration: 21.978963ms)","trace[590323138] 'applied index is now lower than readState.Index' (duration: 181.735548ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:25:48.745044Z","caller":"traceutil/trace.go:171","msg":"trace[1817457369] transaction","detail":"{read_only:false; response_revision:15406; number_of_response:1; }","duration":"204.447871ms","start":"2026-09-08T23:25:48.54058Z","end":"2026-09-08T23:25:48.745028Z","steps":["trace[1817457369] 'process raft request' (duration: 22.635032ms)","trace[1817457369] 'compare' (duration: 181.351115ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T23:25:48.745254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.02769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-08T23:25:48.745343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.139468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-09-08T23:25:48.745385Z","caller":"traceutil/trace.go:171","msg":"trace[1624409912] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15406; }","duration":"204.175334ms","start":"2026-09-08T23:25:48.541181Z","end":"2026-09-08T23:25:48.745356Z","steps":["trace[1624409912] 'agreement among raft nodes before linearized reading' (duration: 203.956528ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:25:48.7454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.858247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-htkm4\" ","response":"range_response_count:1 size:20656"} {"level":"info","ts":"2026-09-08T23:25:48.745409Z","caller":"traceutil/trace.go:171","msg":"trace[1725284012] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15406; }","duration":"104.234641ms","start":"2026-09-08T23:25:48.641156Z","end":"2026-09-08T23:25:48.745391Z","steps":["trace[1725284012] 'agreement among raft nodes before linearized reading' (duration: 104.012014ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:25:48.745523Z","caller":"traceutil/trace.go:171","msg":"trace[961054918] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-htkm4; range_end:; response_count:1; response_revision:15406; }","duration":"162.026051ms","start":"2026-09-08T23:25:48.583478Z","end":"2026-09-08T23:25:48.745505Z","steps":["trace[961054918] 'agreement among raft nodes before linearized reading' (duration: 161.64496ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:25:49.053233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.759319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T23:25:49.053364Z","caller":"traceutil/trace.go:171","msg":"trace[1693192399] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15406; }","duration":"140.899183ms","start":"2026-09-08T23:25:48.912413Z","end":"2026-09-08T23:25:49.053312Z","steps":["trace[1693192399] 'range keys from in-memory index tree' (duration: 140.679516ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:25:49.053397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.429431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"warn","ts":"2026-09-08T23:25:49.053443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.270226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-09-08T23:25:49.053499Z","caller":"traceutil/trace.go:171","msg":"trace[1468319626] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15406; }","duration":"123.539934ms","start":"2026-09-08T23:25:48.929919Z","end":"2026-09-08T23:25:49.053459Z","steps":["trace[1468319626] 'range keys from in-memory index tree' (duration: 123.260186ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:25:49.053526Z","caller":"traceutil/trace.go:171","msg":"trace[1274242753] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15406; }","duration":"136.354519ms","start":"2026-09-08T23:25:48.917156Z","end":"2026-09-08T23:25:49.053511Z","steps":["trace[1274242753] 'range keys from in-memory index tree' (duration: 136.04316ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:25:49.053903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.238829ms","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-09-08T23:25:49.053968Z","caller":"traceutil/trace.go:171","msg":"trace[404742733] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15406; }","duration":"146.356132ms","start":"2026-09-08T23:25:48.907597Z","end":"2026-09-08T23:25:49.053953Z","steps":["trace[404742733] 'range keys from in-memory index tree' (duration: 146.062073ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:25:49.054574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.443567ms","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-09-08T23:25:49.054727Z","caller":"traceutil/trace.go:171","msg":"trace[2001738797] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15406; }","duration":"171.585771ms","start":"2026-09-08T23:25:48.883084Z","end":"2026-09-08T23:25:49.05467Z","steps":["trace[2001738797] 'range keys from in-memory index tree' (duration: 171.260762ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:25:49.204181Z","caller":"traceutil/trace.go:171","msg":"trace[1859920253] transaction","detail":"{read_only:false; response_revision:15407; number_of_response:1; }","duration":"145.516637ms","start":"2026-09-08T23:25:49.058613Z","end":"2026-09-08T23:25:49.20413Z","steps":["trace[1859920253] 'process raft request' (duration: 145.31383ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:25:49.2104Z","caller":"traceutil/trace.go:171","msg":"trace[1805562760] transaction","detail":"{read_only:false; response_revision:15408; number_of_response:1; }","duration":"149.538616ms","start":"2026-09-08T23:25:49.060836Z","end":"2026-09-08T23:25:49.210375Z","steps":["trace[1805562760] 'process raft request' (duration: 149.216216ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:25:49.430101Z","caller":"traceutil/trace.go:171","msg":"trace[938240790] transaction","detail":"{read_only:false; response_revision:15409; number_of_response:1; }","duration":"203.569675ms","start":"2026-09-08T23:25:49.226488Z","end":"2026-09-08T23:25:49.430057Z","steps":["trace[938240790] 'process raft request' (duration: 198.807536ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:30:13.654186Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15223} {"level":"info","ts":"2026-09-08T23:30:13.755282Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15223,"took":"98.44781ms","hash":109716633,"current-db-size-bytes":56299520,"current-db-size":"56 MB","current-db-size-in-use-bytes":31678464,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-08T23:30:13.755355Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":109716633,"revision":15223,"compact-revision":12765} {"level":"warn","ts":"2026-09-08T23:31:37.386355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.844314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-ltqmd\" ","response":"range_response_count:1 size:22129"} {"level":"info","ts":"2026-09-08T23:31:37.386477Z","caller":"traceutil/trace.go:171","msg":"trace[20891586] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-ltqmd; range_end:; response_count:1; response_revision:17989; }","duration":"123.05175ms","start":"2026-09-08T23:31:37.2634Z","end":"2026-09-08T23:31:37.386452Z","steps":["trace[20891586] 'range keys from in-memory index tree' (duration: 122.524305ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:31:37.386967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.554612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.82\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-09-08T23:31:37.387098Z","caller":"traceutil/trace.go:171","msg":"trace[277108733] range","detail":"{range_begin:/registry/masterleases/162.253.55.82; range_end:; response_count:1; response_revision:17989; }","duration":"127.754357ms","start":"2026-09-08T23:31:37.259307Z","end":"2026-09-08T23:31:37.387061Z","steps":["trace[277108733] 'range keys from in-memory index tree' (duration: 127.006335ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:31:44.103449Z","caller":"traceutil/trace.go:171","msg":"trace[360901110] transaction","detail":"{read_only:false; response_revision:18026; number_of_response:1; }","duration":"170.90934ms","start":"2026-09-08T23:31:43.932511Z","end":"2026-09-08T23:31:44.10342Z","steps":["trace[360901110] 'process raft request' (duration: 170.740665ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:31:44.438529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.417891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-gv898\" ","response":"range_response_count:1 size:9799"} {"level":"info","ts":"2026-09-08T23:31:44.438706Z","caller":"traceutil/trace.go:171","msg":"trace[1564669731] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-gv898; range_end:; response_count:1; response_revision:18026; }","duration":"151.619287ms","start":"2026-09-08T23:31:44.28703Z","end":"2026-09-08T23:31:44.43865Z","steps":["trace[1564669731] 'range keys from in-memory index tree' (duration: 151.12777ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:31:44.438763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.119513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-08T23:31:44.438915Z","caller":"traceutil/trace.go:171","msg":"trace[312494963] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18026; }","duration":"216.459223ms","start":"2026-09-08T23:31:44.22243Z","end":"2026-09-08T23:31:44.438889Z","steps":["trace[312494963] 'range keys from in-memory index tree' (duration: 216.00762ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:31:44.862878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.183546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-09-08T23:31:44.862959Z","caller":"traceutil/trace.go:171","msg":"trace[1378955310] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18027; }","duration":"280.31864ms","start":"2026-09-08T23:31:44.582622Z","end":"2026-09-08T23:31:44.862941Z","steps":["trace[1378955310] 'range keys from in-memory index tree' (duration: 279.94991ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:31:45.048655Z","caller":"traceutil/trace.go:171","msg":"trace[1256818326] transaction","detail":"{read_only:false; response_revision:18028; number_of_response:1; }","duration":"306.027772ms","start":"2026-09-08T23:31:44.742583Z","end":"2026-09-08T23:31:45.048611Z","steps":["trace[1256818326] 'process raft request' (duration: 305.764155ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:31:45.048986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:31:44.742556Z","time spent":"306.310851ms","remote":"127.0.0.1:56562","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-09-08T23:31:45.141913Z","caller":"traceutil/trace.go:171","msg":"trace[1555965025] transaction","detail":"{read_only:false; response_revision:18029; number_of_response:1; }","duration":"274.344636ms","start":"2026-09-08T23:31:44.867535Z","end":"2026-09-08T23:31:45.14188Z","steps":["trace[1555965025] 'process raft request' (duration: 274.041287ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:31:45.142302Z","caller":"traceutil/trace.go:171","msg":"trace[2000938913] transaction","detail":"{read_only:false; response_revision:18030; number_of_response:1; }","duration":"159.863226ms","start":"2026-09-08T23:31:44.982406Z","end":"2026-09-08T23:31:45.142269Z","steps":["trace[2000938913] 'process raft request' (duration: 159.413833ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:31:45.142756Z","caller":"traceutil/trace.go:171","msg":"trace[231297036] transaction","detail":"{read_only:false; response_revision:18031; number_of_response:1; }","duration":"157.558ms","start":"2026-09-08T23:31:44.985152Z","end":"2026-09-08T23:31:45.14271Z","steps":["trace[231297036] 'process raft request' (duration: 157.014873ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:31:45.142928Z","caller":"traceutil/trace.go:171","msg":"trace[1418418287] linearizableReadLoop","detail":"{readStateIndex:18646; appliedIndex:18644; }","duration":"272.894124ms","start":"2026-09-08T23:31:44.870017Z","end":"2026-09-08T23:31:45.142912Z","steps":["trace[1418418287] 'read index received' (duration: 178.349247ms)","trace[1418418287] 'applied index is now lower than readState.Index' (duration: 94.543566ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:31:45.143138Z","caller":"traceutil/trace.go:171","msg":"trace[1378380686] transaction","detail":"{read_only:false; response_revision:18032; number_of_response:1; }","duration":"155.942441ms","start":"2026-09-08T23:31:44.987174Z","end":"2026-09-08T23:31:45.143117Z","steps":["trace[1378380686] 'process raft request' (duration: 155.465318ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:31:45.143158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.110429ms","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-09-08T23:31:45.143249Z","caller":"traceutil/trace.go:171","msg":"trace[1353367842] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18032; }","duration":"273.254523ms","start":"2026-09-08T23:31:44.86997Z","end":"2026-09-08T23:31:45.143224Z","steps":["trace[1353367842] 'agreement among raft nodes before linearized reading' (duration: 272.999126ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:34:16.109319Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c5298098e2dc0f92","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-08T23:34:16.116699Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-09-08T23:34:16.116931Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-09-08T23:35:13.660403Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17419} {"level":"info","ts":"2026-09-08T23:35:13.762998Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17419,"took":"97.929445ms","hash":3713799696,"current-db-size-bytes":56299520,"current-db-size":"56 MB","current-db-size-in-use-bytes":34168832,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-09-08T23:35:13.763105Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3713799696,"revision":17419,"compact-revision":15223} {"level":"warn","ts":"2026-09-08T23:37:32.813134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.637922ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-08T23:37:32.813543Z","caller":"traceutil/trace.go:171","msg":"trace[161598307] transaction","detail":"{read_only:false; response_revision:20718; number_of_response:1; }","duration":"203.797702ms","start":"2026-09-08T23:37:32.609702Z","end":"2026-09-08T23:37:32.813499Z","steps":["trace[161598307] 'process raft request' (duration: 203.543925ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:37:32.813543Z","caller":"traceutil/trace.go:171","msg":"trace[1521448943] transaction","detail":"{read_only:false; response_revision:20717; number_of_response:1; }","duration":"254.217377ms","start":"2026-09-08T23:37:32.559244Z","end":"2026-09-08T23:37:32.813462Z","steps":["trace[1521448943] 'process raft request' (duration: 84.133081ms)","trace[1521448943] 'compare' (duration: 169.104967ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:37:32.813607Z","caller":"traceutil/trace.go:171","msg":"trace[1613624383] linearizableReadLoop","detail":"{readStateIndex:21424; appliedIndex:21422; }","duration":"171.259661ms","start":"2026-09-08T23:37:32.642278Z","end":"2026-09-08T23:37:32.813538Z","steps":["trace[1613624383] 'read index received' (duration: 1.107713ms)","trace[1613624383] 'applied index is now lower than readState.Index' (duration: 170.141478ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T23:37:32.975187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.801663ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"warn","ts":"2026-09-08T23:37:32.975594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.265099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-09-08T23:37:32.975702Z","caller":"traceutil/trace.go:171","msg":"trace[1553076065] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20718; }","duration":"333.456846ms","start":"2026-09-08T23:37:32.642216Z","end":"2026-09-08T23:37:32.975673Z","steps":["trace[1553076065] 'agreement among raft nodes before linearized reading' (duration: 171.515268ms)","trace[1553076065] 'range keys from in-memory index tree' (duration: 161.623088ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T23:37:32.975755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:37:32.642191Z","time spent":"333.553459ms","remote":"127.0.0.1:56562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":582,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-09-08T23:37:33.165668Z","caller":"traceutil/trace.go:171","msg":"trace[838773318] transaction","detail":"{read_only:false; response_revision:20719; number_of_response:1; }","duration":"235.804378ms","start":"2026-09-08T23:37:32.929836Z","end":"2026-09-08T23:37:33.165641Z","steps":["trace[838773318] 'process raft request' (duration: 235.594102ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:37:33.451524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.383226ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-08T23:37:33.45169Z","caller":"traceutil/trace.go:171","msg":"trace[302871696] transaction","detail":"{read_only:false; response_revision:20721; number_of_response:1; }","duration":"280.093674ms","start":"2026-09-08T23:37:33.171571Z","end":"2026-09-08T23:37:33.451665Z","steps":["trace[302871696] 'process raft request' (duration: 280.045442ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:37:33.451797Z","caller":"traceutil/trace.go:171","msg":"trace[860229776] transaction","detail":"{read_only:false; response_revision:20720; number_of_response:1; }","duration":"470.905656ms","start":"2026-09-08T23:37:32.980884Z","end":"2026-09-08T23:37:33.45179Z","steps":["trace[860229776] 'process raft request' (duration: 316.176519ms)","trace[860229776] 'compare' (duration: 154.143109ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T23:37:33.45183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:37:32.980852Z","time spent":"470.956818ms","remote":"127.0.0.1:56562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T23:37:33.451916Z","caller":"traceutil/trace.go:171","msg":"trace[1125481922] linearizableReadLoop","detail":"{readStateIndex:21427; appliedIndex:21425; }","duration":"322.31972ms","start":"2026-09-08T23:37:33.129563Z","end":"2026-09-08T23:37:33.451883Z","steps":["trace[1125481922] 'read index received' (duration: 35.946742ms)","trace[1125481922] 'applied index is now lower than readState.Index' (duration: 286.370018ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T23:37:33.452013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.449124ms","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-09-08T23:37:33.452086Z","caller":"traceutil/trace.go:171","msg":"trace[1209138008] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:20721; }","duration":"322.573007ms","start":"2026-09-08T23:37:33.129498Z","end":"2026-09-08T23:37:33.452071Z","steps":["trace[1209138008] 'agreement among raft nodes before linearized reading' (duration: 322.458964ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:37:33.452119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:37:33.129453Z","time spent":"322.6567ms","remote":"127.0.0.1:53194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":30,"request content":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true "} {"level":"warn","ts":"2026-09-08T23:37:33.452139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.172396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-08T23:37:33.452191Z","caller":"traceutil/trace.go:171","msg":"trace[1436874137] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:20721; }","duration":"280.284759ms","start":"2026-09-08T23:37:33.171889Z","end":"2026-09-08T23:37:33.452174Z","steps":["trace[1436874137] 'agreement among raft nodes before linearized reading' (duration: 280.175836ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:37:33.452264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.74418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-08T23:37:33.452288Z","caller":"traceutil/trace.go:171","msg":"trace[1891208559] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20721; }","duration":"230.847963ms","start":"2026-09-08T23:37:33.221433Z","end":"2026-09-08T23:37:33.452281Z","steps":["trace[1891208559] 'agreement among raft nodes before linearized reading' (duration: 230.802292ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:37:33.452451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.980991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-09-08T23:37:33.452529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.811588ms","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-09-08T23:37:33.452528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.786627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-09-08T23:37:33.45255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.477537ms","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-09-08T23:37:33.452566Z","caller":"traceutil/trace.go:171","msg":"trace[1668128185] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20721; }","duration":"169.865309ms","start":"2026-09-08T23:37:33.282688Z","end":"2026-09-08T23:37:33.452554Z","steps":["trace[1668128185] 'agreement among raft nodes before linearized reading' (duration: 169.763596ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:37:33.452561Z","caller":"traceutil/trace.go:171","msg":"trace[1841662630] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20721; }","duration":"173.126055ms","start":"2026-09-08T23:37:33.279402Z","end":"2026-09-08T23:37:33.452528Z","steps":["trace[1841662630] 'agreement among raft nodes before linearized reading' (duration: 172.805446ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:37:33.452591Z","caller":"traceutil/trace.go:171","msg":"trace[105080196] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20721; }","duration":"236.870099ms","start":"2026-09-08T23:37:33.215704Z","end":"2026-09-08T23:37:33.452574Z","steps":["trace[105080196] 'agreement among raft nodes before linearized reading' (duration: 236.674044ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:37:33.452641Z","caller":"traceutil/trace.go:171","msg":"trace[29661679] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20721; }","duration":"225.635811ms","start":"2026-09-08T23:37:33.226953Z","end":"2026-09-08T23:37:33.452589Z","steps":["trace[29661679] 'agreement among raft nodes before linearized reading' (duration: 225.368773ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:37:33.615474Z","caller":"traceutil/trace.go:171","msg":"trace[1113142158] transaction","detail":"{read_only:false; response_revision:20722; number_of_response:1; }","duration":"158.085504ms","start":"2026-09-08T23:37:33.45736Z","end":"2026-09-08T23:37:33.615446Z","steps":["trace[1113142158] 'process raft request' (duration: 145.791545ms)","trace[1113142158] 'compare' (duration: 12.190786ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:37:33.635698Z","caller":"traceutil/trace.go:171","msg":"trace[665350550] transaction","detail":"{read_only:false; response_revision:20723; number_of_response:1; }","duration":"178.218433ms","start":"2026-09-08T23:37:33.457454Z","end":"2026-09-08T23:37:33.635673Z","steps":["trace[665350550] 'process raft request' (duration: 178.047868ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:37:33.635996Z","caller":"traceutil/trace.go:171","msg":"trace[537331584] transaction","detail":"{read_only:false; response_revision:20725; number_of_response:1; }","duration":"176.739041ms","start":"2026-09-08T23:37:33.459234Z","end":"2026-09-08T23:37:33.635973Z","steps":["trace[537331584] 'process raft request' (duration: 176.610357ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:37:33.636049Z","caller":"traceutil/trace.go:171","msg":"trace[1772918337] transaction","detail":"{read_only:false; response_revision:20724; number_of_response:1; }","duration":"178.406259ms","start":"2026-09-08T23:37:33.457605Z","end":"2026-09-08T23:37:33.636011Z","steps":["trace[1772918337] 'process raft request' (duration: 178.019708ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:37:33.935582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.79343ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-08T23:37:33.935696Z","caller":"traceutil/trace.go:171","msg":"trace[628925962] transaction","detail":"{read_only:false; response_revision:20726; number_of_response:1; }","duration":"220.423148ms","start":"2026-09-08T23:37:33.715252Z","end":"2026-09-08T23:37:33.935675Z","steps":["trace[628925962] 'process raft request' (duration: 66.412993ms)","trace[628925962] 'compare' (duration: 153.519451ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:40:13.66658Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19756} {"level":"info","ts":"2026-09-08T23:40:13.79385Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19756,"took":"123.361761ms","hash":3968464269,"current-db-size-bytes":56299520,"current-db-size":"56 MB","current-db-size-in-use-bytes":29872128,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-09-08T23:40:13.79391Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3968464269,"revision":19756,"compact-revision":17419} {"level":"warn","ts":"2026-09-08T23:41:35.962705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.052205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-08T23:41:35.962835Z","caller":"traceutil/trace.go:171","msg":"trace[828939506] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:23220; }","duration":"264.247901ms","start":"2026-09-08T23:41:35.698557Z","end":"2026-09-08T23:41:35.962805Z","steps":["trace[828939506] 'count revisions from in-memory index tree' (duration: 263.968033ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:41:35.962821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.617892ms","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":"info","ts":"2026-09-08T23:41:35.962926Z","caller":"traceutil/trace.go:171","msg":"trace[77596088] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:23220; }","duration":"102.786007ms","start":"2026-09-08T23:41:35.86011Z","end":"2026-09-08T23:41:35.962896Z","steps":["trace[77596088] 'count revisions from in-memory index tree' (duration: 102.468147ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:41:35.963889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.9683ms","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-09-08T23:41:35.96396Z","caller":"traceutil/trace.go:171","msg":"trace[554350557] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:23220; }","duration":"255.040102ms","start":"2026-09-08T23:41:35.708903Z","end":"2026-09-08T23:41:35.963943Z","steps":["trace[554350557] 'range keys from in-memory index tree' (duration: 254.144656ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:41:36.020065Z","caller":"traceutil/trace.go:171","msg":"trace[441924811] transaction","detail":"{read_only:false; response_revision:23221; number_of_response:1; }","duration":"135.66041ms","start":"2026-09-08T23:41:35.88438Z","end":"2026-09-08T23:41:36.020041Z","steps":["trace[441924811] 'process raft request' (duration: 135.508865ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:41:36.022765Z","caller":"traceutil/trace.go:171","msg":"trace[636714424] transaction","detail":"{read_only:false; response_revision:23222; number_of_response:1; }","duration":"137.990767ms","start":"2026-09-08T23:41:35.88475Z","end":"2026-09-08T23:41:36.022741Z","steps":["trace[636714424] 'process raft request' (duration: 137.837942ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:45:13.675026Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21994} {"level":"info","ts":"2026-09-08T23:45:13.79265Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21994,"took":"113.651315ms","hash":1528192110,"current-db-size-bytes":56299520,"current-db-size":"56 MB","current-db-size-in-use-bytes":42983424,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-09-08T23:45:13.792725Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1528192110,"revision":21994,"compact-revision":19756} {"level":"info","ts":"2026-09-08T23:50:10.918839Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006e69.wal"} {"level":"info","ts":"2026-09-08T23:50:13.68174Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25158} {"level":"info","ts":"2026-09-08T23:50:13.834879Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25158,"took":"147.852349ms","hash":3626081195,"current-db-size-bytes":56299520,"current-db-size":"56 MB","current-db-size-in-use-bytes":30298112,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-09-08T23:50:13.834939Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3626081195,"revision":25158,"compact-revision":21994}