{"level":"warn","ts":"2026-09-19T06:05:03.183656Z","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-19T06:05:03.183758Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.175: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.175:2380","--initial-cluster=instance=https://162.253.55.175:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.175:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.175: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-19T06:05:03.183832Z","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-19T06:05:03.183848Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.175:2380"]} {"level":"info","ts":"2026-09-19T06:05:03.183874Z","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-19T06:05:03.184679Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.175:2379"]} {"level":"info","ts":"2026-09-19T06:05:03.184773Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.175:2380"],"listen-peer-urls":["https://162.253.55.175:2380"],"advertise-client-urls":["https://162.253.55.175:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.175:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.175: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-19T06:05:03.189958Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.908982ms"} {"level":"info","ts":"2026-09-19T06:05:03.202855Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5420a740f4813dc9","cluster-id":"5ecb181dc9675400"} {"level":"info","ts":"2026-09-19T06:05:03.202946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 switched to configuration voters=()"} {"level":"info","ts":"2026-09-19T06:05:03.202969Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 became follower at term 0"} {"level":"info","ts":"2026-09-19T06:05:03.202981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5420a740f4813dc9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-19T06:05:03.202988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 became follower at term 1"} {"level":"info","ts":"2026-09-19T06:05:03.203025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 switched to configuration voters=(6062028995862543817)"} {"level":"warn","ts":"2026-09-19T06:05:03.219289Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-19T06:05:03.220765Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-19T06:05:03.222398Z","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-19T06:05:03.224945Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5420a740f4813dc9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-19T06:05:03.225026Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5420a740f4813dc9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-19T06:05:03.225388Z","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-19T06:05:03.22544Z","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-19T06:05:03.225451Z","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-19T06:05:03.22805Z","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-19T06:05:03.228183Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.175:2380"} {"level":"info","ts":"2026-09-19T06:05:03.228218Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.175:2380"} {"level":"info","ts":"2026-09-19T06:05:03.228229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 switched to configuration voters=(6062028995862543817)"} {"level":"info","ts":"2026-09-19T06:05:03.228275Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5420a740f4813dc9","initial-advertise-peer-urls":["https://162.253.55.175:2380"],"listen-peer-urls":["https://162.253.55.175:2380"],"advertise-client-urls":["https://162.253.55.175:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.175:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-19T06:05:03.228317Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-19T06:05:03.228321Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5ecb181dc9675400","local-member-id":"5420a740f4813dc9","added-peer-id":"5420a740f4813dc9","added-peer-peer-urls":["https://162.253.55.175:2380"]} {"level":"info","ts":"2026-09-19T06:05:03.903833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 is starting a new election at term 1"} {"level":"info","ts":"2026-09-19T06:05:03.903916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-19T06:05:03.903941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 received MsgPreVoteResp from 5420a740f4813dc9 at term 1"} {"level":"info","ts":"2026-09-19T06:05:03.903958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 became candidate at term 2"} {"level":"info","ts":"2026-09-19T06:05:03.903968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 received MsgVoteResp from 5420a740f4813dc9 at term 2"} {"level":"info","ts":"2026-09-19T06:05:03.903989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 became leader at term 2"} {"level":"info","ts":"2026-09-19T06:05:03.904007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5420a740f4813dc9 elected leader 5420a740f4813dc9 at term 2"} {"level":"info","ts":"2026-09-19T06:05:03.905342Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5420a740f4813dc9","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.175:2379]}","request-path":"/0/members/5420a740f4813dc9/attributes","cluster-id":"5ecb181dc9675400","publish-timeout":"7s"} {"level":"info","ts":"2026-09-19T06:05:03.905343Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T06:05:03.905435Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T06:05:03.905518Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T06:05:03.905794Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-19T06:05:03.905815Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-19T06:05:03.906947Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5ecb181dc9675400","local-member-id":"5420a740f4813dc9","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T06:05:03.90708Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T06:05:03.907158Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T06:05:03.90876Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.175:2379"} {"level":"info","ts":"2026-09-19T06:05:03.909405Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-09-19T06:05:42.465871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.635487ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-09-19T06:05:42.466081Z","caller":"traceutil/trace.go:171","msg":"trace[1839307] linearizableReadLoop","detail":"{readStateIndex:506; appliedIndex:505; }","duration":"201.562305ms","start":"2026-09-19T06:05:42.264459Z","end":"2026-09-19T06:05:42.466022Z","steps":["trace[1839307] 'read index received' (duration: 81.618252ms)","trace[1839307] 'applied index is now lower than readState.Index' (duration: 119.926253ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:05:42.466225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.7475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:05:42.466262Z","caller":"traceutil/trace.go:171","msg":"trace[1196609901] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:488; }","duration":"201.793961ms","start":"2026-09-19T06:05:42.264456Z","end":"2026-09-19T06:05:42.46625Z","steps":["trace[1196609901] 'agreement among raft nodes before linearized reading' (duration: 201.719ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:05:42.466356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.939439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-09-19T06:05:42.46648Z","caller":"traceutil/trace.go:171","msg":"trace[529301855] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:488; }","duration":"190.127373ms","start":"2026-09-19T06:05:42.276327Z","end":"2026-09-19T06:05:42.466454Z","steps":["trace[529301855] 'agreement among raft nodes before linearized reading' (duration: 189.883978ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:05:48.712293Z","caller":"traceutil/trace.go:171","msg":"trace[725219914] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:616; }","duration":"210.605458ms","start":"2026-09-19T06:05:48.501656Z","end":"2026-09-19T06:05:48.712262Z","steps":["trace[725219914] 'read index received' (duration: 208.930126ms)","trace[725219914] 'applied index is now lower than readState.Index' (duration: 1.674512ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:05:48.712373Z","caller":"traceutil/trace.go:171","msg":"trace[20837602] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"296.071602ms","start":"2026-09-19T06:05:48.416283Z","end":"2026-09-19T06:05:48.712355Z","steps":["trace[20837602] 'process raft request' (duration: 294.604044ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:05:48.712583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.896904ms","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-19T06:05:48.712685Z","caller":"traceutil/trace.go:171","msg":"trace[1025269826] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:593; }","duration":"211.057567ms","start":"2026-09-19T06:05:48.501602Z","end":"2026-09-19T06:05:48.71266Z","steps":["trace[1025269826] 'agreement among raft nodes before linearized reading' (duration: 210.791822ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:05:48.907456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.006006ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T06:05:48.90787Z","caller":"traceutil/trace.go:171","msg":"trace[1760464987] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:617; }","duration":"116.197302ms","start":"2026-09-19T06:05:48.791651Z","end":"2026-09-19T06:05:48.907849Z","steps":["trace[1760464987] 'read index received' (duration: 108.954961ms)","trace[1760464987] 'applied index is now lower than readState.Index' (duration: 7.241201ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:05:48.907958Z","caller":"traceutil/trace.go:171","msg":"trace[896293684] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"126.197546ms","start":"2026-09-19T06:05:48.781751Z","end":"2026-09-19T06:05:48.907948Z","steps":["trace[896293684] 'process raft request' (duration: 126.027292ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:05:48.908101Z","caller":"traceutil/trace.go:171","msg":"trace[2082099396] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"186.621032ms","start":"2026-09-19T06:05:48.72144Z","end":"2026-09-19T06:05:48.908061Z","steps":["trace[2082099396] 'process raft request' (duration: 12.460833ms)","trace[2082099396] 'compare' (duration: 172.874834ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:05:48.908143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.491167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:05:48.908206Z","caller":"traceutil/trace.go:171","msg":"trace[266491445] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:595; }","duration":"116.573609ms","start":"2026-09-19T06:05:48.791605Z","end":"2026-09-19T06:05:48.908179Z","steps":["trace[266491445] 'agreement among raft nodes before linearized reading' (duration: 116.471477ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:05:49.667414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.223255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-c55lx\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-19T06:05:49.667521Z","caller":"traceutil/trace.go:171","msg":"trace[2007322449] range","detail":"{range_begin:/registry/pods/kube-system/cilium-c55lx; range_end:; response_count:1; response_revision:596; }","duration":"497.400699ms","start":"2026-09-19T06:05:49.170093Z","end":"2026-09-19T06:05:49.667494Z","steps":["trace[2007322449] 'range keys from in-memory index tree' (duration: 497.013551ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:05:49.667594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:05:49.170075Z","time spent":"497.498041ms","remote":"127.0.0.1:54676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-c55lx\" "} {"level":"info","ts":"2026-09-19T06:05:49.677892Z","caller":"traceutil/trace.go:171","msg":"trace[2012164855] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"335.586633ms","start":"2026-09-19T06:05:49.342277Z","end":"2026-09-19T06:05:49.677864Z","steps":["trace[2012164855] 'process raft request' (duration: 335.025782ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:05:49.678142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:05:49.342245Z","time spent":"335.786397ms","remote":"127.0.0.1:54582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T06:05:51.482255Z","caller":"traceutil/trace.go:171","msg":"trace[55341949] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"162.404393ms","start":"2026-09-19T06:05:51.319786Z","end":"2026-09-19T06:05:51.48219Z","steps":["trace[55341949] 'process raft request' (duration: 161.716039ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:06:05.245216Z","caller":"traceutil/trace.go:171","msg":"trace[1420800816] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"198.942454ms","start":"2026-09-19T06:06:05.046246Z","end":"2026-09-19T06:06:05.245189Z","steps":["trace[1420800816] 'process raft request' (duration: 138.67228ms)","trace[1420800816] 'compare' (duration: 60.124511ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:06:36.682735Z","caller":"traceutil/trace.go:171","msg":"trace[646350657] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"321.379702ms","start":"2026-09-19T06:06:36.361288Z","end":"2026-09-19T06:06:36.682668Z","steps":["trace[646350657] 'process raft request' (duration: 320.768173ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:06:36.682971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:06:36.361252Z","time spent":"321.600325ms","remote":"127.0.0.1:54754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T06:06:36.683325Z","caller":"traceutil/trace.go:171","msg":"trace[1726436666] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"104.712989ms","start":"2026-09-19T06:06:36.578578Z","end":"2026-09-19T06:06:36.683291Z","steps":["trace[1726436666] 'process raft request' (duration: 104.543646ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:11.654846Z","caller":"traceutil/trace.go:171","msg":"trace[597785321] transaction","detail":"{read_only:false; response_revision:1620; number_of_response:1; }","duration":"153.175167ms","start":"2026-09-19T06:07:11.501632Z","end":"2026-09-19T06:07:11.654807Z","steps":["trace[597785321] 'process raft request' (duration: 110.457662ms)","trace[597785321] 'compare' (duration: 42.372411ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:07:11.655253Z","caller":"traceutil/trace.go:171","msg":"trace[2011310707] transaction","detail":"{read_only:false; response_revision:1621; number_of_response:1; }","duration":"153.502871ms","start":"2026-09-19T06:07:11.501695Z","end":"2026-09-19T06:07:11.655198Z","steps":["trace[2011310707] 'process raft request' (duration: 152.964565ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:11.655289Z","caller":"traceutil/trace.go:171","msg":"trace[631797665] transaction","detail":"{read_only:false; response_revision:1622; number_of_response:1; }","duration":"148.442657ms","start":"2026-09-19T06:07:11.506803Z","end":"2026-09-19T06:07:11.655246Z","steps":["trace[631797665] 'process raft request' (duration: 148.017382ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:17.713949Z","caller":"traceutil/trace.go:171","msg":"trace[1334327218] transaction","detail":"{read_only:false; response_revision:1722; number_of_response:1; }","duration":"111.359408ms","start":"2026-09-19T06:07:17.602546Z","end":"2026-09-19T06:07:17.713905Z","steps":["trace[1334327218] 'process raft request' (duration: 99.478479ms)","trace[1334327218] 'compare' (duration: 11.730328ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:07:26.065503Z","caller":"traceutil/trace.go:171","msg":"trace[449775026] transaction","detail":"{read_only:false; response_revision:1794; number_of_response:1; }","duration":"106.851581ms","start":"2026-09-19T06:07:25.958626Z","end":"2026-09-19T06:07:26.065478Z","steps":["trace[449775026] 'process raft request' (duration: 104.857047ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:28.432696Z","caller":"traceutil/trace.go:171","msg":"trace[2098956884] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"164.928892ms","start":"2026-09-19T06:07:28.267745Z","end":"2026-09-19T06:07:28.432674Z","steps":["trace[2098956884] 'process raft request' (duration: 164.76735ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:29.021323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.907048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:07:29.021414Z","caller":"traceutil/trace.go:171","msg":"trace[214776867] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1865; }","duration":"259.05275ms","start":"2026-09-19T06:07:28.762339Z","end":"2026-09-19T06:07:29.021392Z","steps":["trace[214776867] 'count revisions from in-memory index tree' (duration: 258.774796ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:29.021528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.302504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-09-19T06:07:29.021618Z","caller":"traceutil/trace.go:171","msg":"trace[1552779217] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1865; }","duration":"196.471355ms","start":"2026-09-19T06:07:28.825124Z","end":"2026-09-19T06:07:29.021595Z","steps":["trace[1552779217] 'range keys from in-memory index tree' (duration: 196.099591ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:29.021677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.609254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2f751ded-5968-4e64-864f-e8dc8e99edae\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-19T06:07:29.021749Z","caller":"traceutil/trace.go:171","msg":"trace[1148869061] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2f751ded-5968-4e64-864f-e8dc8e99edae; range_end:; response_count:1; response_revision:1865; }","duration":"331.731916ms","start":"2026-09-19T06:07:28.689999Z","end":"2026-09-19T06:07:29.021731Z","steps":["trace[1148869061] 'range keys from in-memory index tree' (duration: 331.432122ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:29.021795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:07:28.689979Z","time spent":"331.807197ms","remote":"127.0.0.1:54676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2f751ded-5968-4e64-864f-e8dc8e99edae\" "} {"level":"warn","ts":"2026-09-19T06:07:29.02196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.339947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:07:29.022013Z","caller":"traceutil/trace.go:171","msg":"trace[243188089] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1865; }","duration":"229.428608ms","start":"2026-09-19T06:07:28.792571Z","end":"2026-09-19T06:07:29.022Z","steps":["trace[243188089] 'range keys from in-memory index tree' (duration: 229.268016ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:29.05839Z","caller":"traceutil/trace.go:171","msg":"trace[1331214320] linearizableReadLoop","detail":"{readStateIndex:1939; appliedIndex:1938; }","duration":"136.943569ms","start":"2026-09-19T06:07:28.921418Z","end":"2026-09-19T06:07:29.058362Z","steps":["trace[1331214320] 'read index received' (duration: 136.800147ms)","trace[1331214320] 'applied index is now lower than readState.Index' (duration: 142.412µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:07:29.05841Z","caller":"traceutil/trace.go:171","msg":"trace[2145999280] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"153.300548ms","start":"2026-09-19T06:07:28.905082Z","end":"2026-09-19T06:07:29.058383Z","steps":["trace[2145999280] 'process raft request' (duration: 153.143186ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:29.058877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.387684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-19T06:07:29.058953Z","caller":"traceutil/trace.go:171","msg":"trace[692718554] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1866; }","duration":"137.568747ms","start":"2026-09-19T06:07:28.921366Z","end":"2026-09-19T06:07:29.058934Z","steps":["trace[692718554] 'agreement among raft nodes before linearized reading' (duration: 137.130882ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:29.212367Z","caller":"traceutil/trace.go:171","msg":"trace[507809527] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"186.078743ms","start":"2026-09-19T06:07:29.026253Z","end":"2026-09-19T06:07:29.212332Z","steps":["trace[507809527] 'process raft request' (duration: 185.312304ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:29.21261Z","caller":"traceutil/trace.go:171","msg":"trace[733268782] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"183.182248ms","start":"2026-09-19T06:07:29.029397Z","end":"2026-09-19T06:07:29.212579Z","steps":["trace[733268782] 'process raft request' (duration: 182.602751ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:29.212888Z","caller":"traceutil/trace.go:171","msg":"trace[887114881] linearizableReadLoop","detail":"{readStateIndex:1941; appliedIndex:1939; }","duration":"154.399328ms","start":"2026-09-19T06:07:29.058471Z","end":"2026-09-19T06:07:29.212871Z","steps":["trace[887114881] 'read index received' (duration: 153.211704ms)","trace[887114881] 'applied index is now lower than readState.Index' (duration: 1.186034ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:07:29.213062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.590178ms","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-19T06:07:29.213109Z","caller":"traceutil/trace.go:171","msg":"trace[2005498057] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1868; }","duration":"240.691429ms","start":"2026-09-19T06:07:28.972402Z","end":"2026-09-19T06:07:29.213094Z","steps":["trace[2005498057] 'agreement among raft nodes before linearized reading' (duration: 240.526167ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:29.213369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.138913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:07:29.213646Z","caller":"traceutil/trace.go:171","msg":"trace[2139358210] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1868; }","duration":"190.72964ms","start":"2026-09-19T06:07:29.022889Z","end":"2026-09-19T06:07:29.213619Z","steps":["trace[2139358210] 'agreement among raft nodes before linearized reading' (duration: 190.106233ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:29.212963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.987403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:07:29.214766Z","caller":"traceutil/trace.go:171","msg":"trace[2139506674] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1868; }","duration":"169.899906ms","start":"2026-09-19T06:07:29.044844Z","end":"2026-09-19T06:07:29.214744Z","steps":["trace[2139506674] 'agreement among raft nodes before linearized reading' (duration: 168.011473ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:36.975135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.480381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:07:36.975224Z","caller":"traceutil/trace.go:171","msg":"trace[924808707] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1938; }","duration":"185.622843ms","start":"2026-09-19T06:07:36.789581Z","end":"2026-09-19T06:07:36.975204Z","steps":["trace[924808707] 'range keys from in-memory index tree' (duration: 185.333079ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:37.225747Z","caller":"traceutil/trace.go:171","msg":"trace[897214635] linearizableReadLoop","detail":"{readStateIndex:2013; appliedIndex:2012; }","duration":"110.816704ms","start":"2026-09-19T06:07:37.114912Z","end":"2026-09-19T06:07:37.225728Z","steps":["trace[897214635] 'read index received' (duration: 110.627231ms)","trace[897214635] 'applied index is now lower than readState.Index' (duration: 188.783µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:07:37.225901Z","caller":"traceutil/trace.go:171","msg":"trace[896647383] transaction","detail":"{read_only:false; response_revision:1939; number_of_response:1; }","duration":"140.017373ms","start":"2026-09-19T06:07:37.085746Z","end":"2026-09-19T06:07:37.225764Z","steps":["trace[896647383] 'process raft request' (duration: 139.842321ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:37.225967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.048186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-19T06:07:37.22618Z","caller":"traceutil/trace.go:171","msg":"trace[332631249] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1939; }","duration":"111.276059ms","start":"2026-09-19T06:07:37.114829Z","end":"2026-09-19T06:07:37.226152Z","steps":["trace[332631249] 'agreement among raft nodes before linearized reading' (duration: 110.948225ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:37.225967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.502696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.175\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-19T06:07:37.226256Z","caller":"traceutil/trace.go:171","msg":"trace[59258761] range","detail":"{range_begin:/registry/masterleases/162.253.55.175; range_end:; response_count:1; response_revision:1939; }","duration":"108.79294ms","start":"2026-09-19T06:07:37.117435Z","end":"2026-09-19T06:07:37.226228Z","steps":["trace[59258761] 'agreement among raft nodes before linearized reading' (duration: 108.410625ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:42.119346Z","caller":"traceutil/trace.go:171","msg":"trace[2137606000] linearizableReadLoop","detail":"{readStateIndex:2045; appliedIndex:2044; }","duration":"328.371887ms","start":"2026-09-19T06:07:41.790933Z","end":"2026-09-19T06:07:42.119304Z","steps":["trace[2137606000] 'read index received' (duration: 328.010973ms)","trace[2137606000] 'applied index is now lower than readState.Index' (duration: 359.304µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:07:42.12Z","caller":"traceutil/trace.go:171","msg":"trace[1967321772] transaction","detail":"{read_only:false; response_revision:1970; number_of_response:1; }","duration":"423.97124ms","start":"2026-09-19T06:07:41.695975Z","end":"2026-09-19T06:07:42.119946Z","steps":["trace[1967321772] 'process raft request' (duration: 423.004858ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:42.120172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.940058ms","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-19T06:07:42.120246Z","caller":"traceutil/trace.go:171","msg":"trace[1436389830] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1970; }","duration":"212.07453ms","start":"2026-09-19T06:07:41.908154Z","end":"2026-09-19T06:07:42.120228Z","steps":["trace[1436389830] 'agreement among raft nodes before linearized reading' (duration: 211.822917ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:42.120417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.4867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:07:42.120459Z","caller":"traceutil/trace.go:171","msg":"trace[2005805287] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1970; }","duration":"329.572372ms","start":"2026-09-19T06:07:41.790875Z","end":"2026-09-19T06:07:42.120448Z","steps":["trace[2005805287] 'agreement among raft nodes before linearized reading' (duration: 329.4679ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:42.120497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:07:41.790854Z","time spent":"329.636852ms","remote":"127.0.0.1:54482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-19T06:07:42.120279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:07:41.695943Z","time spent":"424.170343ms","remote":"127.0.0.1:54754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T06:07:43.417522Z","caller":"traceutil/trace.go:171","msg":"trace[2112250955] transaction","detail":"{read_only:false; response_revision:1984; number_of_response:1; }","duration":"107.776702ms","start":"2026-09-19T06:07:43.309708Z","end":"2026-09-19T06:07:43.417484Z","steps":["trace[2112250955] 'process raft request' (duration: 107.456158ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:43.417873Z","caller":"traceutil/trace.go:171","msg":"trace[1360360680] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"106.610988ms","start":"2026-09-19T06:07:43.311236Z","end":"2026-09-19T06:07:43.417847Z","steps":["trace[1360360680] 'process raft request' (duration: 106.469026ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:43.417843Z","caller":"traceutil/trace.go:171","msg":"trace[1744818774] transaction","detail":"{read_only:false; response_revision:1985; number_of_response:1; }","duration":"106.85994ms","start":"2026-09-19T06:07:43.310947Z","end":"2026-09-19T06:07:43.417807Z","steps":["trace[1744818774] 'process raft request' (duration: 106.453426ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:57.901807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.169655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:07:57.901887Z","caller":"traceutil/trace.go:171","msg":"trace[405831548] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2078; }","duration":"109.298406ms","start":"2026-09-19T06:07:57.792572Z","end":"2026-09-19T06:07:57.90187Z","steps":["trace[405831548] 'range keys from in-memory index tree' (duration: 109.092703ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:08:03.519093Z","caller":"traceutil/trace.go:171","msg":"trace[591897699] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"113.290321ms","start":"2026-09-19T06:08:03.405774Z","end":"2026-09-19T06:08:03.519064Z","steps":["trace[591897699] 'process raft request' (duration: 74.107724ms)","trace[591897699] 'compare' (duration: 39.076185ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:08:03.769135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.972484ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T06:08:03.769351Z","caller":"traceutil/trace.go:171","msg":"trace[1719781026] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"201.551236ms","start":"2026-09-19T06:08:03.567776Z","end":"2026-09-19T06:08:03.769327Z","steps":["trace[1719781026] 'process raft request' (duration: 90.280168ms)","trace[1719781026] 'compare' (duration: 110.843513ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:08:04.475189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.160178ms","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-19T06:08:04.475338Z","caller":"traceutil/trace.go:171","msg":"trace[1937234852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2111; }","duration":"186.370421ms","start":"2026-09-19T06:08:04.288943Z","end":"2026-09-19T06:08:04.475313Z","steps":["trace[1937234852] 'range keys from in-memory index tree' (duration: 185.992345ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:08:04.598832Z","caller":"traceutil/trace.go:171","msg":"trace[1570367984] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"118.926553ms","start":"2026-09-19T06:08:04.47987Z","end":"2026-09-19T06:08:04.598797Z","steps":["trace[1570367984] 'process raft request' (duration: 118.65754ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:08:05.242652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.797473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-19T06:08:05.242776Z","caller":"traceutil/trace.go:171","msg":"trace[287708070] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:2115; }","duration":"180.992916ms","start":"2026-09-19T06:08:05.061763Z","end":"2026-09-19T06:08:05.242756Z","steps":["trace[287708070] 'count revisions from in-memory index tree' (duration: 180.646812ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:08:05.717371Z","caller":"traceutil/trace.go:171","msg":"trace[841854453] linearizableReadLoop","detail":"{readStateIndex:2197; appliedIndex:2196; }","duration":"112.148684ms","start":"2026-09-19T06:08:05.605197Z","end":"2026-09-19T06:08:05.717346Z","steps":["trace[841854453] 'read index received' (duration: 112.002793ms)","trace[841854453] 'applied index is now lower than readState.Index' (duration: 144.761µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:08:05.717527Z","caller":"traceutil/trace.go:171","msg":"trace[1532723030] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"132.879789ms","start":"2026-09-19T06:08:05.584615Z","end":"2026-09-19T06:08:05.717495Z","steps":["trace[1532723030] 'process raft request' (duration: 132.533125ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:08:05.717576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.359436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-19T06:08:05.717623Z","caller":"traceutil/trace.go:171","msg":"trace[861022184] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2117; }","duration":"112.467907ms","start":"2026-09-19T06:08:05.60514Z","end":"2026-09-19T06:08:05.717607Z","steps":["trace[861022184] 'agreement among raft nodes before linearized reading' (duration: 112.302835ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:08:34.446605Z","caller":"traceutil/trace.go:171","msg":"trace[321645494] transaction","detail":"{read_only:false; response_revision:2270; number_of_response:1; }","duration":"111.738505ms","start":"2026-09-19T06:08:34.334835Z","end":"2026-09-19T06:08:34.446573Z","steps":["trace[321645494] 'process raft request' (duration: 111.460672ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:09:56.997894Z","caller":"traceutil/trace.go:171","msg":"trace[2004923980] transaction","detail":"{read_only:false; response_revision:2802; number_of_response:1; }","duration":"225.487651ms","start":"2026-09-19T06:09:56.772385Z","end":"2026-09-19T06:09:56.997872Z","steps":["trace[2004923980] 'process raft request' (duration: 225.350696ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:31.339088Z","caller":"traceutil/trace.go:171","msg":"trace[22063427] transaction","detail":"{read_only:false; response_revision:2993; number_of_response:1; }","duration":"205.251344ms","start":"2026-09-19T06:10:31.133797Z","end":"2026-09-19T06:10:31.339048Z","steps":["trace[22063427] 'process raft request' (duration: 205.041388ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:10:31.698813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.692677ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T06:10:31.698914Z","caller":"traceutil/trace.go:171","msg":"trace[1260512293] linearizableReadLoop","detail":"{readStateIndex:3106; appliedIndex:3105; }","duration":"195.754664ms","start":"2026-09-19T06:10:31.503138Z","end":"2026-09-19T06:10:31.698892Z","steps":["trace[1260512293] 'read index received' (duration: 6.787669ms)","trace[1260512293] 'applied index is now lower than readState.Index' (duration: 188.966005ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:10:31.698994Z","caller":"traceutil/trace.go:171","msg":"trace[2026568320] transaction","detail":"{read_only:false; response_revision:2994; number_of_response:1; }","duration":"352.069278ms","start":"2026-09-19T06:10:31.346886Z","end":"2026-09-19T06:10:31.698956Z","steps":["trace[2026568320] 'process raft request' (duration: 163.111404ms)","trace[2026568320] 'compare' (duration: 188.557952ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:10:31.699121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.988732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-19T06:10:31.699157Z","caller":"traceutil/trace.go:171","msg":"trace[1316230893] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2994; }","duration":"196.066604ms","start":"2026-09-19T06:10:31.50308Z","end":"2026-09-19T06:10:31.699146Z","steps":["trace[1316230893] 'agreement among raft nodes before linearized reading' (duration: 195.861448ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:10:31.699192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:10:31.34687Z","time spent":"352.223092ms","remote":"127.0.0.1:54754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T06:10:31.847733Z","caller":"traceutil/trace.go:171","msg":"trace[970465718] transaction","detail":"{read_only:false; response_revision:2995; number_of_response:1; }","duration":"143.475655ms","start":"2026-09-19T06:10:31.704228Z","end":"2026-09-19T06:10:31.847704Z","steps":["trace[970465718] 'process raft request' (duration: 138.711694ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:31.850473Z","caller":"traceutil/trace.go:171","msg":"trace[1696471592] transaction","detail":"{read_only:false; response_revision:2996; number_of_response:1; }","duration":"127.044842ms","start":"2026-09-19T06:10:31.723404Z","end":"2026-09-19T06:10:31.850448Z","steps":["trace[1696471592] 'process raft request' (duration: 126.413803ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:14:51.201299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.114751ms","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-19T06:14:51.201404Z","caller":"traceutil/trace.go:171","msg":"trace[148893946] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4904; }","duration":"105.428286ms","start":"2026-09-19T06:14:51.095951Z","end":"2026-09-19T06:14:51.201379Z","steps":["trace[148893946] 'agreement among raft nodes before linearized reading' (duration: 105.016179ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:14:52.043701Z","caller":"traceutil/trace.go:171","msg":"trace[445804885] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"304.608857ms","start":"2026-09-19T06:14:51.739064Z","end":"2026-09-19T06:14:52.043673Z","steps":["trace[445804885] 'process raft request' (duration: 288.982111ms)","trace[445804885] 'compare' (duration: 15.500914ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:14:52.043877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:14:51.73905Z","time spent":"304.746039ms","remote":"127.0.0.1:54650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1328,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T06:14:52.057774Z","caller":"traceutil/trace.go:171","msg":"trace[522116289] linearizableReadLoop","detail":"{readStateIndex:5132; appliedIndex:5129; }","duration":"296.453713ms","start":"2026-09-19T06:14:51.7613Z","end":"2026-09-19T06:14:52.057754Z","steps":["trace[522116289] 'read index received' (duration: 266.878259ms)","trace[522116289] 'applied index is now lower than readState.Index' (duration: 29.574404ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:14:52.057831Z","caller":"traceutil/trace.go:171","msg":"trace[820419428] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"318.357002ms","start":"2026-09-19T06:14:51.739449Z","end":"2026-09-19T06:14:52.057806Z","steps":["trace[820419428] 'process raft request' (duration: 318.061027ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:14:52.057912Z","caller":"traceutil/trace.go:171","msg":"trace[111067339] transaction","detail":"{read_only:false; response_revision:4945; number_of_response:1; }","duration":"238.093227ms","start":"2026-09-19T06:14:51.819796Z","end":"2026-09-19T06:14:52.057889Z","steps":["trace[111067339] 'process raft request' (duration: 237.903634ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:14:52.057978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:14:51.739431Z","time spent":"318.475233ms","remote":"127.0.0.1:54768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1902,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T06:14:52.058072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.58118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-09-19T06:14:52.058165Z","caller":"traceutil/trace.go:171","msg":"trace[1366715771] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4945; }","duration":"234.702362ms","start":"2026-09-19T06:14:51.823444Z","end":"2026-09-19T06:14:52.058146Z","steps":["trace[1366715771] 'agreement among raft nodes before linearized reading' (duration: 234.506289ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:14:52.057995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.681787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"warn","ts":"2026-09-19T06:14:52.058227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.290952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:14:52.058366Z","caller":"traceutil/trace.go:171","msg":"trace[786881517] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4945; }","duration":"268.493926ms","start":"2026-09-19T06:14:51.789854Z","end":"2026-09-19T06:14:52.058348Z","steps":["trace[786881517] 'agreement among raft nodes before linearized reading' (duration: 268.092279ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:14:52.058297Z","caller":"traceutil/trace.go:171","msg":"trace[1879840950] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4945; }","duration":"296.992181ms","start":"2026-09-19T06:14:51.761271Z","end":"2026-09-19T06:14:52.058263Z","steps":["trace[1879840950] 'agreement among raft nodes before linearized reading' (duration: 296.598375ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:14:52.057913Z","caller":"traceutil/trace.go:171","msg":"trace[369924636] transaction","detail":"{read_only:false; response_revision:4944; number_of_response:1; }","duration":"309.061789ms","start":"2026-09-19T06:14:51.748827Z","end":"2026-09-19T06:14:52.057889Z","steps":["trace[369924636] 'process raft request' (duration: 308.794165ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:14:52.058597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:14:51.74881Z","time spent":"309.7297ms","remote":"127.0.0.1:54994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5194,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T06:14:52.916567Z","caller":"traceutil/trace.go:171","msg":"trace[56368014] linearizableReadLoop","detail":"{readStateIndex:5146; appliedIndex:5145; }","duration":"124.07728ms","start":"2026-09-19T06:14:52.792464Z","end":"2026-09-19T06:14:52.916541Z","steps":["trace[56368014] 'read index received' (duration: 97.231111ms)","trace[56368014] 'applied index is now lower than readState.Index' (duration: 26.845239ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:14:52.916801Z","caller":"traceutil/trace.go:171","msg":"trace[1660629395] transaction","detail":"{read_only:false; response_revision:4957; number_of_response:1; }","duration":"191.995061ms","start":"2026-09-19T06:14:52.72478Z","end":"2026-09-19T06:14:52.916775Z","steps":["trace[1660629395] 'process raft request' (duration: 164.914448ms)","trace[1660629395] 'compare' (duration: 26.742347ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:14:52.916702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.230422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:14:52.916984Z","caller":"traceutil/trace.go:171","msg":"trace[1244172830] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4957; }","duration":"124.525987ms","start":"2026-09-19T06:14:52.792375Z","end":"2026-09-19T06:14:52.916901Z","steps":["trace[1244172830] 'agreement among raft nodes before linearized reading' (duration: 124.272803ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:14:53.197077Z","caller":"traceutil/trace.go:171","msg":"trace[1146887400] transaction","detail":"{read_only:false; response_revision:4958; number_of_response:1; }","duration":"259.922638ms","start":"2026-09-19T06:14:52.937122Z","end":"2026-09-19T06:14:53.197045Z","steps":["trace[1146887400] 'process raft request' (duration: 240.745744ms)","trace[1146887400] 'compare' (duration: 18.502113ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:14:53.1972Z","caller":"traceutil/trace.go:171","msg":"trace[875768010] transaction","detail":"{read_only:false; response_revision:4959; number_of_response:1; }","duration":"137.914814ms","start":"2026-09-19T06:14:53.059261Z","end":"2026-09-19T06:14:53.197176Z","steps":["trace[875768010] 'process raft request' (duration: 137.475367ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:14:56.923387Z","caller":"traceutil/trace.go:171","msg":"trace[1454098334] transaction","detail":"{read_only:false; response_revision:5015; number_of_response:1; }","duration":"131.597045ms","start":"2026-09-19T06:14:56.791772Z","end":"2026-09-19T06:14:56.923369Z","steps":["trace[1454098334] 'process raft request' (duration: 131.457702ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:15:03.936443Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2848} {"level":"info","ts":"2026-09-19T06:15:04.005029Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2848,"took":"67.181718ms","hash":4294420538,"current-db-size-bytes":51310592,"current-db-size":"51 MB","current-db-size-in-use-bytes":26648576,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-19T06:15:04.005073Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4294420538,"revision":2848,"compact-revision":-1} {"level":"info","ts":"2026-09-19T06:15:05.459212Z","caller":"traceutil/trace.go:171","msg":"trace[620199771] transaction","detail":"{read_only:false; response_revision:5189; number_of_response:1; }","duration":"125.060112ms","start":"2026-09-19T06:15:05.334122Z","end":"2026-09-19T06:15:05.459182Z","steps":["trace[620199771] 'process raft request' (duration: 124.801448ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:15:05.489578Z","caller":"traceutil/trace.go:171","msg":"trace[1873831978] linearizableReadLoop","detail":"{readStateIndex:5387; appliedIndex:5385; }","duration":"110.367144ms","start":"2026-09-19T06:15:05.379169Z","end":"2026-09-19T06:15:05.489536Z","steps":["trace[1873831978] 'read index received' (duration: 79.667348ms)","trace[1873831978] 'applied index is now lower than readState.Index' (duration: 30.698336ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:15:05.489696Z","caller":"traceutil/trace.go:171","msg":"trace[1976124539] transaction","detail":"{read_only:false; response_revision:5190; number_of_response:1; }","duration":"113.80873ms","start":"2026-09-19T06:15:05.375876Z","end":"2026-09-19T06:15:05.489684Z","steps":["trace[1976124539] 'process raft request' (duration: 113.102788ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:15:05.489874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.68375ms","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-19T06:15:05.489921Z","caller":"traceutil/trace.go:171","msg":"trace[122805976] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5190; }","duration":"110.781102ms","start":"2026-09-19T06:15:05.379129Z","end":"2026-09-19T06:15:05.48991Z","steps":["trace[122805976] 'agreement among raft nodes before linearized reading' (duration: 110.630379ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:15:05.984827Z","caller":"traceutil/trace.go:171","msg":"trace[405715967] transaction","detail":"{read_only:false; response_revision:5196; number_of_response:1; }","duration":"131.538597ms","start":"2026-09-19T06:15:05.853271Z","end":"2026-09-19T06:15:05.98481Z","steps":["trace[405715967] 'process raft request' (duration: 131.421495ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:15:06.049547Z","caller":"traceutil/trace.go:171","msg":"trace[771152429] transaction","detail":"{read_only:false; response_revision:5197; number_of_response:1; }","duration":"193.821854ms","start":"2026-09-19T06:15:05.855694Z","end":"2026-09-19T06:15:06.049516Z","steps":["trace[771152429] 'process raft request' (duration: 186.495955ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:15:19.165242Z","caller":"traceutil/trace.go:171","msg":"trace[426012494] linearizableReadLoop","detail":"{readStateIndex:5576; appliedIndex:5575; }","duration":"176.700526ms","start":"2026-09-19T06:15:18.988508Z","end":"2026-09-19T06:15:19.165209Z","steps":["trace[426012494] 'read index received' (duration: 176.411151ms)","trace[426012494] 'applied index is now lower than readState.Index' (duration: 287.465µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:15:19.16533Z","caller":"traceutil/trace.go:171","msg":"trace[934186699] transaction","detail":"{read_only:false; response_revision:5373; number_of_response:1; }","duration":"185.083449ms","start":"2026-09-19T06:15:18.980172Z","end":"2026-09-19T06:15:19.165256Z","steps":["trace[934186699] 'process raft request' (duration: 184.785915ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:15:19.165557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.019961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-09-19T06:15:19.165648Z","caller":"traceutil/trace.go:171","msg":"trace[42086966] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5373; }","duration":"177.155082ms","start":"2026-09-19T06:15:18.988469Z","end":"2026-09-19T06:15:19.165624Z","steps":["trace[42086966] 'agreement among raft nodes before linearized reading' (duration: 176.887788ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:15:19.312497Z","caller":"traceutil/trace.go:171","msg":"trace[648323127] linearizableReadLoop","detail":"{readStateIndex:5577; appliedIndex:5576; }","duration":"139.079954ms","start":"2026-09-19T06:15:19.173391Z","end":"2026-09-19T06:15:19.312471Z","steps":["trace[648323127] 'read index received' (duration: 99.090805ms)","trace[648323127] 'applied index is now lower than readState.Index' (duration: 39.988169ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:15:19.312607Z","caller":"traceutil/trace.go:171","msg":"trace[566790420] transaction","detail":"{read_only:false; response_revision:5374; number_of_response:1; }","duration":"139.48393ms","start":"2026-09-19T06:15:19.17311Z","end":"2026-09-19T06:15:19.312594Z","steps":["trace[566790420] 'process raft request' (duration: 99.363238ms)","trace[566790420] 'compare' (duration: 39.676675ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:15:19.313001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.527441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-aee3f6a4-f402-42a1-91bf-9ceb2cacc2f2\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-09-19T06:15:19.313108Z","caller":"traceutil/trace.go:171","msg":"trace[1409247730] range","detail":"{range_begin:/registry/persistentvolumes/pvc-aee3f6a4-f402-42a1-91bf-9ceb2cacc2f2; range_end:; response_count:1; response_revision:5374; }","duration":"139.757365ms","start":"2026-09-19T06:15:19.173318Z","end":"2026-09-19T06:15:19.313076Z","steps":["trace[1409247730] 'agreement among raft nodes before linearized reading' (duration: 139.388889ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:15:19.567051Z","caller":"traceutil/trace.go:171","msg":"trace[1745122136] linearizableReadLoop","detail":"{readStateIndex:5580; appliedIndex:5577; }","duration":"254.467548ms","start":"2026-09-19T06:15:19.312562Z","end":"2026-09-19T06:15:19.567029Z","steps":["trace[1745122136] 'read index received' (duration: 236.564752ms)","trace[1745122136] 'applied index is now lower than readState.Index' (duration: 17.901626ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:15:19.567167Z","caller":"traceutil/trace.go:171","msg":"trace[1964806995] transaction","detail":"{read_only:false; response_revision:5376; number_of_response:1; }","duration":"393.290237ms","start":"2026-09-19T06:15:19.173867Z","end":"2026-09-19T06:15:19.567157Z","steps":["trace[1964806995] 'process raft request' (duration: 393.012603ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:15:19.567277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:15:19.173839Z","time spent":"393.350629ms","remote":"127.0.0.1:54768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1506,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T06:15:19.567302Z","caller":"traceutil/trace.go:171","msg":"trace[1429657099] transaction","detail":"{read_only:false; response_revision:5377; number_of_response:1; }","duration":"393.316048ms","start":"2026-09-19T06:15:19.173933Z","end":"2026-09-19T06:15:19.567249Z","steps":["trace[1429657099] 'process raft request' (duration: 393.032753ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:15:19.567357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.068936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone-nodes\" ","response":"range_response_count:1 size:1265"} {"level":"info","ts":"2026-09-19T06:15:19.567371Z","caller":"traceutil/trace.go:171","msg":"trace[989113081] transaction","detail":"{read_only:false; response_revision:5375; number_of_response:1; }","duration":"393.674624ms","start":"2026-09-19T06:15:19.173635Z","end":"2026-09-19T06:15:19.56731Z","steps":["trace[989113081] 'process raft request' (duration: 375.472383ms)","trace[989113081] 'compare' (duration: 17.54654ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:15:19.56744Z","caller":"traceutil/trace.go:171","msg":"trace[64405192] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone-nodes; range_end:; response_count:1; response_revision:5377; }","duration":"390.168158ms","start":"2026-09-19T06:15:19.177252Z","end":"2026-09-19T06:15:19.56742Z","steps":["trace[64405192] 'agreement among raft nodes before linearized reading' (duration: 389.948164ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:15:19.567483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:15:19.177249Z","time spent":"390.225229ms","remote":"127.0.0.1:54680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1287,"request content":"key:\"/registry/services/specs/openstack/rabbitmq-keystone-nodes\" "} {"level":"warn","ts":"2026-09-19T06:15:19.5675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.245019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16551"} {"level":"warn","ts":"2026-09-19T06:15:19.567547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:15:19.173904Z","time spent":"393.509151ms","remote":"127.0.0.1:54768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1429,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T06:15:19.567578Z","caller":"traceutil/trace.go:171","msg":"trace[2131457118] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5377; }","duration":"390.352331ms","start":"2026-09-19T06:15:19.177204Z","end":"2026-09-19T06:15:19.567556Z","steps":["trace[2131457118] 'agreement among raft nodes before linearized reading' (duration: 390.114027ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:15:19.567629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:15:19.177198Z","time spent":"390.418612ms","remote":"127.0.0.1:54676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":16573,"request content":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-09-19T06:15:19.567639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:15:19.173604Z","time spent":"393.883327ms","remote":"127.0.0.1:54650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T06:15:19.571489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.872938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-09-19T06:15:19.571641Z","caller":"traceutil/trace.go:171","msg":"trace[380871673] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5378; }","duration":"254.079852ms","start":"2026-09-19T06:15:19.317543Z","end":"2026-09-19T06:15:19.571622Z","steps":["trace[380871673] 'agreement among raft nodes before linearized reading' (duration: 253.832238ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:15:19.711847Z","caller":"traceutil/trace.go:171","msg":"trace[201011606] transaction","detail":"{read_only:false; response_revision:5381; number_of_response:1; }","duration":"103.319361ms","start":"2026-09-19T06:15:19.6085Z","end":"2026-09-19T06:15:19.71182Z","steps":["trace[201011606] 'process raft request' (duration: 81.767087ms)","trace[201011606] 'compare' (duration: 21.122637ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:15:20.685498Z","caller":"traceutil/trace.go:171","msg":"trace[557747412] linearizableReadLoop","detail":"{readStateIndex:5594; appliedIndex:5592; }","duration":"149.01275ms","start":"2026-09-19T06:15:20.536426Z","end":"2026-09-19T06:15:20.685439Z","steps":["trace[557747412] 'read index received' (duration: 7.509729ms)","trace[557747412] 'applied index is now lower than readState.Index' (duration: 141.501871ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:15:20.685785Z","caller":"traceutil/trace.go:171","msg":"trace[1320254702] transaction","detail":"{read_only:false; response_revision:5391; number_of_response:1; }","duration":"182.647308ms","start":"2026-09-19T06:15:20.503112Z","end":"2026-09-19T06:15:20.68576Z","steps":["trace[1320254702] 'process raft request' (duration: 182.112509ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:15:20.68586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.293155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:15:20.686427Z","caller":"traceutil/trace.go:171","msg":"trace[2142034596] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:5391; }","duration":"150.016206ms","start":"2026-09-19T06:15:20.536374Z","end":"2026-09-19T06:15:20.68639Z","steps":["trace[2142034596] 'agreement among raft nodes before linearized reading' (duration: 149.304905ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:15:20.898904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.995004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:15:20.89898Z","caller":"traceutil/trace.go:171","msg":"trace[494713398] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5391; }","duration":"106.123356ms","start":"2026-09-19T06:15:20.79284Z","end":"2026-09-19T06:15:20.898963Z","steps":["trace[494713398] 'range keys from in-memory index tree' (duration: 105.852151ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:16:08.724465Z","caller":"traceutil/trace.go:171","msg":"trace[648008271] transaction","detail":"{read_only:false; response_revision:5769; number_of_response:1; }","duration":"168.376307ms","start":"2026-09-19T06:16:08.556062Z","end":"2026-09-19T06:16:08.724439Z","steps":["trace[648008271] 'process raft request' (duration: 168.200825ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:19:11.929508Z","caller":"traceutil/trace.go:171","msg":"trace[812809332] transaction","detail":"{read_only:false; response_revision:7034; number_of_response:1; }","duration":"121.889796ms","start":"2026-09-19T06:19:11.807594Z","end":"2026-09-19T06:19:11.929484Z","steps":["trace[812809332] 'process raft request' (duration: 121.752501ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:20:03.942863Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5118} {"level":"info","ts":"2026-09-19T06:20:04.034925Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5118,"took":"90.584202ms","hash":3751973047,"current-db-size-bytes":51310592,"current-db-size":"51 MB","current-db-size-in-use-bytes":19382272,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-19T06:20:04.034967Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3751973047,"revision":5118,"compact-revision":2848}