{"level":"warn","ts":"2026-04-18T22:18:02.086154Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-18T22:18:02.086251Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.233:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.233:2380","--initial-cluster=instance=https://199.204.45.233:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.233:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.233: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-04-18T22:18:02.086319Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-18T22:18:02.086333Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.233:2380"]} {"level":"info","ts":"2026-04-18T22:18:02.086355Z","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-04-18T22:18:02.086954Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"]} {"level":"info","ts":"2026-04-18T22:18:02.087022Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.233:2380"],"listen-peer-urls":["https://199.204.45.233:2380"],"advertise-client-urls":["https://199.204.45.233:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.233: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-04-18T22:18:02.093961Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.741932ms"} {"level":"info","ts":"2026-04-18T22:18:02.101246Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"90a0cb2044183f95","cluster-id":"782fef34d5ea94f9"} {"level":"info","ts":"2026-04-18T22:18:02.101452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=()"} {"level":"info","ts":"2026-04-18T22:18:02.101504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became follower at term 0"} {"level":"info","ts":"2026-04-18T22:18:02.10154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 90a0cb2044183f95 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-18T22:18:02.101564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became follower at term 1"} {"level":"info","ts":"2026-04-18T22:18:02.101641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=(10421552877177159573)"} {"level":"warn","ts":"2026-04-18T22:18:02.107148Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-18T22:18:02.10842Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-18T22:18:02.109565Z","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-04-18T22:18:02.11196Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"90a0cb2044183f95","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-18T22:18:02.11211Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"90a0cb2044183f95","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-18T22:18:02.112345Z","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-04-18T22:18:02.112463Z","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-04-18T22:18:02.112479Z","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-04-18T22:18:02.113583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=(10421552877177159573)"} {"level":"info","ts":"2026-04-18T22:18:02.114352Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"782fef34d5ea94f9","local-member-id":"90a0cb2044183f95","added-peer-id":"90a0cb2044183f95","added-peer-peer-urls":["https://199.204.45.233:2380"]} {"level":"info","ts":"2026-04-18T22:18:02.116797Z","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-04-18T22:18:02.116956Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.233:2380"} {"level":"info","ts":"2026-04-18T22:18:02.117012Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.233:2380"} {"level":"info","ts":"2026-04-18T22:18:02.117058Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"90a0cb2044183f95","initial-advertise-peer-urls":["https://199.204.45.233:2380"],"listen-peer-urls":["https://199.204.45.233:2380"],"advertise-client-urls":["https://199.204.45.233:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-18T22:18:02.117123Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-18T22:18:02.602523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 is starting a new election at term 1"} {"level":"info","ts":"2026-04-18T22:18:02.602586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-18T22:18:02.602632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 received MsgPreVoteResp from 90a0cb2044183f95 at term 1"} {"level":"info","ts":"2026-04-18T22:18:02.602669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became candidate at term 2"} {"level":"info","ts":"2026-04-18T22:18:02.602682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 received MsgVoteResp from 90a0cb2044183f95 at term 2"} {"level":"info","ts":"2026-04-18T22:18:02.602709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became leader at term 2"} {"level":"info","ts":"2026-04-18T22:18:02.602729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 90a0cb2044183f95 elected leader 90a0cb2044183f95 at term 2"} {"level":"info","ts":"2026-04-18T22:18:02.603594Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:18:02.604542Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T22:18:02.604537Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"90a0cb2044183f95","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.233:2379]}","request-path":"/0/members/90a0cb2044183f95/attributes","cluster-id":"782fef34d5ea94f9","publish-timeout":"7s"} {"level":"info","ts":"2026-04-18T22:18:02.604601Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T22:18:02.604968Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-18T22:18:02.605087Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-18T22:18:02.60809Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-18T22:18:02.608302Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"782fef34d5ea94f9","local-member-id":"90a0cb2044183f95","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:18:02.608312Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.233:2379"} {"level":"info","ts":"2026-04-18T22:18:02.608459Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:18:02.608492Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:18:32.295537Z","caller":"traceutil/trace.go:171","msg":"trace[2068216233] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"615.594227ms","start":"2026-04-18T22:18:31.679904Z","end":"2026-04-18T22:18:32.295499Z","steps":["trace[2068216233] 'process raft request' (duration: 615.425201ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:32.296312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:31.679881Z","time spent":"615.75196ms","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T22:18:32.826466Z","caller":"traceutil/trace.go:171","msg":"trace[15329631] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"1.143445697s","start":"2026-04-18T22:18:31.682983Z","end":"2026-04-18T22:18:32.826429Z","steps":["trace[15329631] 'process raft request' (duration: 1.143230042s)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:32.826564Z","caller":"traceutil/trace.go:171","msg":"trace[466931326] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"1.142063769s","start":"2026-04-18T22:18:31.684476Z","end":"2026-04-18T22:18:32.826539Z","steps":["trace[466931326] 'process raft request' (duration: 1.141868784s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:32.826654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:31.682958Z","time spent":"1.143626251s","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T22:18:32.826688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:31.684457Z","time spent":"1.142169052s","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T22:18:32.826862Z","caller":"traceutil/trace.go:171","msg":"trace[1823819275] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"1.119261113s","start":"2026-04-18T22:18:31.707566Z","end":"2026-04-18T22:18:32.826827Z","steps":["trace[1823819275] 'process raft request' (duration: 1.118864762s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:32.827023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:31.707545Z","time spent":"1.119412507s","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T22:18:32.827169Z","caller":"traceutil/trace.go:171","msg":"trace[1749249932] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"1.123265581s","start":"2026-04-18T22:18:31.703892Z","end":"2026-04-18T22:18:32.827157Z","steps":["trace[1749249932] 'process raft request' (duration: 1.12249554s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:32.827226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:31.703874Z","time spent":"1.123324352s","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T22:18:32.827286Z","caller":"traceutil/trace.go:171","msg":"trace[1019924600] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"1.11917714s","start":"2026-04-18T22:18:31.708094Z","end":"2026-04-18T22:18:32.827271Z","steps":["trace[1019924600] 'process raft request' (duration: 1.118411269s)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:32.827328Z","caller":"traceutil/trace.go:171","msg":"trace[552262288] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"1.099502178s","start":"2026-04-18T22:18:31.727815Z","end":"2026-04-18T22:18:32.827317Z","steps":["trace[552262288] 'process raft request' (duration: 1.099132369s)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:32.82724Z","caller":"traceutil/trace.go:171","msg":"trace[578366780] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:521; }","duration":"924.229426ms","start":"2026-04-18T22:18:31.902981Z","end":"2026-04-18T22:18:32.82721Z","steps":["trace[578366780] 'read index received' (duration: 392.47542ms)","trace[578366780] 'applied index is now lower than readState.Index' (duration: 531.752956ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:18:32.827487Z","caller":"traceutil/trace.go:171","msg":"trace[464871767] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"1.104959696s","start":"2026-04-18T22:18:31.722426Z","end":"2026-04-18T22:18:32.827385Z","steps":["trace[464871767] 'process raft request' (duration: 1.104414492s)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:32.827547Z","caller":"traceutil/trace.go:171","msg":"trace[449770628] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"991.561288ms","start":"2026-04-18T22:18:31.835928Z","end":"2026-04-18T22:18:32.82749Z","steps":["trace[449770628] 'process raft request' (duration: 991.214889ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:32.827622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"924.604526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-18T22:18:32.827669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:31.835901Z","time spent":"991.711343ms","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T22:18:32.827684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:31.722417Z","time spent":"1.105179562s","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T22:18:32.8277Z","caller":"traceutil/trace.go:171","msg":"trace[142682944] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:516; }","duration":"924.76463ms","start":"2026-04-18T22:18:31.902922Z","end":"2026-04-18T22:18:32.827687Z","steps":["trace[142682944] 'agreement among raft nodes before linearized reading' (duration: 924.557104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:32.827733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:31.902898Z","time spent":"924.827112ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-18T22:18:32.827357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:31.708086Z","time spent":"1.119241971s","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T22:18:32.827379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:31.727796Z","time spent":"1.099560749s","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T22:18:32.827398Z","caller":"traceutil/trace.go:171","msg":"trace[2144784880] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"1.111843212s","start":"2026-04-18T22:18:31.715402Z","end":"2026-04-18T22:18:32.827245Z","steps":["trace[2144784880] 'process raft request' (duration: 1.111192084s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:32.82789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:31.715385Z","time spent":"1.112479089s","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T22:18:32.827467Z","caller":"traceutil/trace.go:171","msg":"trace[1960515254] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"1.116638142s","start":"2026-04-18T22:18:31.710818Z","end":"2026-04-18T22:18:32.827456Z","steps":["trace[1960515254] 'process raft request' (duration: 1.115733597s)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:32.827505Z","caller":"traceutil/trace.go:171","msg":"trace[2049629334] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"1.084853441s","start":"2026-04-18T22:18:31.742591Z","end":"2026-04-18T22:18:32.827445Z","steps":["trace[2049629334] 'process raft request' (duration: 1.08442033s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:32.828027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:31.710792Z","time spent":"1.117156396s","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T22:18:32.828096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:31.742571Z","time spent":"1.085491238s","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T22:18:33.274258Z","caller":"traceutil/trace.go:171","msg":"trace[1399406630] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"972.805861ms","start":"2026-04-18T22:18:32.301406Z","end":"2026-04-18T22:18:33.274212Z","steps":["trace[1399406630] 'process raft request' (duration: 970.379565ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:33.274359Z","caller":"traceutil/trace.go:171","msg":"trace[178308300] transaction","detail":"{read_only:false; number_of_response:1; response_revision:518; }","duration":"970.513189ms","start":"2026-04-18T22:18:32.303833Z","end":"2026-04-18T22:18:33.274346Z","steps":["trace[178308300] 'process raft request' (duration: 970.337774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:33.274369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.310340183s","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-04-18T22:18:33.274421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:32.301388Z","time spent":"972.967295ms","remote":"127.0.0.1:54156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T22:18:33.274448Z","caller":"traceutil/trace.go:171","msg":"trace[226017283] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:518; }","duration":"1.310482697s","start":"2026-04-18T22:18:31.963952Z","end":"2026-04-18T22:18:33.274434Z","steps":["trace[226017283] 'agreement among raft nodes before linearized reading' (duration: 1.310334613s)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:33.274262Z","caller":"traceutil/trace.go:171","msg":"trace[1872643077] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:533; }","duration":"446.708476ms","start":"2026-04-18T22:18:32.827517Z","end":"2026-04-18T22:18:33.274225Z","steps":["trace[1872643077] 'read index received' (duration: 444.498686ms)","trace[1872643077] 'applied index is now lower than readState.Index' (duration: 2.20868ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:18:33.27427Z","caller":"traceutil/trace.go:171","msg":"trace[277361695] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"970.731895ms","start":"2026-04-18T22:18:32.303499Z","end":"2026-04-18T22:18:33.274231Z","steps":["trace[277361695] 'process raft request' (duration: 970.59999ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:33.27469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:31.963935Z","time spent":"1.310562428s","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-18T22:18:33.274687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"872.984419ms","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-04-18T22:18:33.27477Z","caller":"traceutil/trace.go:171","msg":"trace[1153099158] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:518; }","duration":"873.105563ms","start":"2026-04-18T22:18:32.401638Z","end":"2026-04-18T22:18:33.274744Z","steps":["trace[1153099158] 'agreement among raft nodes before linearized reading' (duration: 872.862317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:33.274787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:32.30349Z","time spent":"971.201836ms","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:18:33.274834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:32.401623Z","time spent":"873.197925ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-18T22:18:33.274739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:32.303824Z","time spent":"970.57288ms","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7366,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:18:33.279182Z","caller":"traceutil/trace.go:171","msg":"trace[1547616669] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"445.950316ms","start":"2026-04-18T22:18:32.833222Z","end":"2026-04-18T22:18:33.279172Z","steps":["trace[1547616669] 'process raft request' (duration: 445.805902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:33.279233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:32.833205Z","time spent":"445.999267ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:18:33.279379Z","caller":"traceutil/trace.go:171","msg":"trace[216312488] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"440.773796ms","start":"2026-04-18T22:18:32.83858Z","end":"2026-04-18T22:18:33.279354Z","steps":["trace[216312488] 'process raft request' (duration: 440.645353ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:33.279526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:32.838574Z","time spent":"440.858279ms","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:18:33.279578Z","caller":"traceutil/trace.go:171","msg":"trace[476897606] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"445.303278ms","start":"2026-04-18T22:18:32.834266Z","end":"2026-04-18T22:18:33.279569Z","steps":["trace[476897606] 'process raft request' (duration: 444.923249ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:33.279664Z","caller":"traceutil/trace.go:171","msg":"trace[1392753245] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"391.244575ms","start":"2026-04-18T22:18:32.888411Z","end":"2026-04-18T22:18:33.279656Z","steps":["trace[1392753245] 'process raft request' (duration: 391.217474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:33.2797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:32.888392Z","time spent":"391.293767ms","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T22:18:33.279722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:32.834252Z","time spent":"445.407191ms","remote":"127.0.0.1:54156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T22:18:33.279784Z","caller":"traceutil/trace.go:171","msg":"trace[1578548763] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"432.088982ms","start":"2026-04-18T22:18:32.847689Z","end":"2026-04-18T22:18:33.279778Z","steps":["trace[1578548763] 'process raft request' (duration: 431.765592ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:33.279794Z","caller":"traceutil/trace.go:171","msg":"trace[1859020194] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"436.368327ms","start":"2026-04-18T22:18:32.843392Z","end":"2026-04-18T22:18:33.279761Z","steps":["trace[1859020194] 'process raft request' (duration: 435.884274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:33.279824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:32.84768Z","time spent":"432.123432ms","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:18:33.279892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:32.843375Z","time spent":"436.465849ms","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:18:33.279904Z","caller":"traceutil/trace.go:171","msg":"trace[1455834044] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"428.062863ms","start":"2026-04-18T22:18:32.851827Z","end":"2026-04-18T22:18:33.27989Z","steps":["trace[1455834044] 'process raft request' (duration: 427.756824ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:33.279519Z","caller":"traceutil/trace.go:171","msg":"trace[789178604] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"443.070528ms","start":"2026-04-18T22:18:32.836416Z","end":"2026-04-18T22:18:33.279486Z","steps":["trace[789178604] 'process raft request' (duration: 442.790391ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:33.279975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:32.836401Z","time spent":"443.561301ms","remote":"127.0.0.1:54156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T22:18:33.279977Z","caller":"traceutil/trace.go:171","msg":"trace[404720330] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"446.632724ms","start":"2026-04-18T22:18:32.833307Z","end":"2026-04-18T22:18:33.27994Z","steps":["trace[404720330] 'process raft request' (duration: 445.828162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:33.280024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:32.851798Z","time spent":"428.144485ms","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:18:33.280057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.870226ms","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-04-18T22:18:33.280063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:32.833303Z","time spent":"446.719357ms","remote":"127.0.0.1:54156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T22:18:33.280095Z","caller":"traceutil/trace.go:171","msg":"trace[1401578484] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:528; }","duration":"346.935068ms","start":"2026-04-18T22:18:32.933146Z","end":"2026-04-18T22:18:33.280081Z","steps":["trace[1401578484] 'agreement among raft nodes before linearized reading' (duration: 346.867646ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:33.279456Z","caller":"traceutil/trace.go:171","msg":"trace[1294777877] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"445.997597ms","start":"2026-04-18T22:18:32.833401Z","end":"2026-04-18T22:18:33.279398Z","steps":["trace[1294777877] 'process raft request' (duration: 445.767041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:33.280131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:32.933125Z","time spent":"346.998859ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-18T22:18:33.280207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:32.833386Z","time spent":"446.778088ms","remote":"127.0.0.1:54156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T22:18:39.343092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.77906ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:18:39.343279Z","caller":"traceutil/trace.go:171","msg":"trace[38513336] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"186.988384ms","start":"2026-04-18T22:18:39.156262Z","end":"2026-04-18T22:18:39.34325Z","steps":["trace[38513336] 'process raft request' (duration: 73.852055ms)","trace[38513336] 'compare' (duration: 112.639146ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:18:40.555391Z","caller":"traceutil/trace.go:171","msg":"trace[1646068864] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"750.863036ms","start":"2026-04-18T22:18:39.804499Z","end":"2026-04-18T22:18:40.555362Z","steps":["trace[1646068864] 'process raft request' (duration: 750.26707ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:40.556475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:39.804452Z","time spent":"751.939504ms","remote":"127.0.0.1:53764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:18:41.890963Z","caller":"traceutil/trace.go:171","msg":"trace[320960169] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"217.383841ms","start":"2026-04-18T22:18:41.673555Z","end":"2026-04-18T22:18:41.890939Z","steps":["trace[320960169] 'process raft request' (duration: 217.249777ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:23.797198Z","caller":"traceutil/trace.go:171","msg":"trace[864058679] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"135.776338ms","start":"2026-04-18T22:19:23.661338Z","end":"2026-04-18T22:19:23.797115Z","steps":["trace[864058679] 'process raft request' (duration: 132.339086ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:23.797405Z","caller":"traceutil/trace.go:171","msg":"trace[35083674] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"134.602428ms","start":"2026-04-18T22:19:23.662772Z","end":"2026-04-18T22:19:23.797375Z","steps":["trace[35083674] 'process raft request' (duration: 134.469464ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:23.797468Z","caller":"traceutil/trace.go:171","msg":"trace[2134103239] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"134.876855ms","start":"2026-04-18T22:19:23.662538Z","end":"2026-04-18T22:19:23.797415Z","steps":["trace[2134103239] 'process raft request' (duration: 134.478794ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:38.991442Z","caller":"traceutil/trace.go:171","msg":"trace[1951665761] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"119.43792ms","start":"2026-04-18T22:19:38.871946Z","end":"2026-04-18T22:19:38.991384Z","steps":["trace[1951665761] 'process raft request' (duration: 119.178702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:20:10.486055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.764469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:20:10.486155Z","caller":"traceutil/trace.go:171","msg":"trace[1649467576] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1839; }","duration":"179.926533ms","start":"2026-04-18T22:20:10.30621Z","end":"2026-04-18T22:20:10.486136Z","steps":["trace[1649467576] 'count revisions from in-memory index tree' (duration: 179.670107ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:20:10.572583Z","caller":"traceutil/trace.go:171","msg":"trace[1006677506] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"186.940949ms","start":"2026-04-18T22:20:10.385618Z","end":"2026-04-18T22:20:10.572559Z","steps":["trace[1006677506] 'process raft request' (duration: 186.750664ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:20:10.573228Z","caller":"traceutil/trace.go:171","msg":"trace[487320625] linearizableReadLoop","detail":"{readStateIndex:1907; appliedIndex:1907; }","duration":"185.769517ms","start":"2026-04-18T22:20:10.387446Z","end":"2026-04-18T22:20:10.573215Z","steps":["trace[487320625] 'read index received' (duration: 185.765257ms)","trace[487320625] 'applied index is now lower than readState.Index' (duration: 3.56µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:20:10.573508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.076626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-aa5f8039-448b-406f-bfdf-788570f66990\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-18T22:20:10.573552Z","caller":"traceutil/trace.go:171","msg":"trace[1690449657] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-aa5f8039-448b-406f-bfdf-788570f66990; range_end:; response_count:1; response_revision:1840; }","duration":"186.171709ms","start":"2026-04-18T22:20:10.387368Z","end":"2026-04-18T22:20:10.57354Z","steps":["trace[1690449657] 'agreement among raft nodes before linearized reading' (duration: 186.028915ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:20:11.05739Z","caller":"traceutil/trace.go:171","msg":"trace[1327704536] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"529.991783ms","start":"2026-04-18T22:20:10.527371Z","end":"2026-04-18T22:20:11.057362Z","steps":["trace[1327704536] 'process raft request' (duration: 529.846999ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:20:11.057388Z","caller":"traceutil/trace.go:171","msg":"trace[377658445] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"582.812238ms","start":"2026-04-18T22:20:10.474518Z","end":"2026-04-18T22:20:11.05733Z","steps":["trace[377658445] 'process raft request' (duration: 485.476146ms)","trace[377658445] 'compare' (duration: 96.994712ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:20:11.057611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:20:10.527333Z","time spent":"530.159426ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:20:11.057612Z","caller":"traceutil/trace.go:171","msg":"trace[604448561] linearizableReadLoop","detail":"{readStateIndex:1909; appliedIndex:1907; }","duration":"484.320025ms","start":"2026-04-18T22:20:10.57326Z","end":"2026-04-18T22:20:11.05758Z","steps":["trace[604448561] 'read index received' (duration: 386.49139ms)","trace[604448561] 'applied index is now lower than readState.Index' (duration: 97.824705ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:20:11.057735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:20:10.474492Z","time spent":"583.039554ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:20:11.216873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.525875ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-04-18T22:20:11.216903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"808.019047ms","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-04-18T22:20:11.217015Z","caller":"traceutil/trace.go:171","msg":"trace[1982262115] linearizableReadLoop","detail":"{readStateIndex:1910; appliedIndex:1909; }","duration":"159.312479ms","start":"2026-04-18T22:20:11.057679Z","end":"2026-04-18T22:20:11.216992Z","steps":["trace[1982262115] 'read index received' (duration: 93.352µs)","trace[1982262115] 'applied index is now lower than readState.Index' (duration: 159.214467ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:20:11.217079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.359292ms","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":"warn","ts":"2026-04-18T22:20:11.217067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.886817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:20:11.217145Z","caller":"traceutil/trace.go:171","msg":"trace[1053561608] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1842; }","duration":"555.436424ms","start":"2026-04-18T22:20:10.661684Z","end":"2026-04-18T22:20:11.21712Z","steps":["trace[1053561608] 'agreement among raft nodes before linearized reading' (duration: 555.314801ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:20:11.217167Z","caller":"traceutil/trace.go:171","msg":"trace[1547328901] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1842; }","duration":"173.027541ms","start":"2026-04-18T22:20:11.04411Z","end":"2026-04-18T22:20:11.217137Z","steps":["trace[1547328901] 'agreement among raft nodes before linearized reading' (duration: 172.883117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:20:11.217199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:20:10.661664Z","time spent":"555.525816ms","remote":"127.0.0.1:38582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-18T22:20:11.217007Z","caller":"traceutil/trace.go:171","msg":"trace[2097639373] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1842; }","duration":"808.144301ms","start":"2026-04-18T22:20:10.408831Z","end":"2026-04-18T22:20:11.216976Z","steps":["trace[2097639373] 'agreement among raft nodes before linearized reading' (duration: 648.908513ms)","trace[2097639373] 'range keys from in-memory index tree' (duration: 158.95536ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:20:11.217456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:20:10.408826Z","time spent":"808.613563ms","remote":"127.0.0.1:38582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-18T22:20:11.217201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.874574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:20:11.217584Z","caller":"traceutil/trace.go:171","msg":"trace[1420517760] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1842; }","duration":"643.299135ms","start":"2026-04-18T22:20:10.574266Z","end":"2026-04-18T22:20:11.217565Z","steps":["trace[1420517760] 'agreement among raft nodes before linearized reading' (duration: 642.871154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:20:11.217639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:20:10.574242Z","time spent":"643.379668ms","remote":"127.0.0.1:53690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T22:20:11.216906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"827.75181ms","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-04-18T22:20:11.217731Z","caller":"traceutil/trace.go:171","msg":"trace[762687165] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1842; }","duration":"828.629202ms","start":"2026-04-18T22:20:10.389083Z","end":"2026-04-18T22:20:11.217712Z","steps":["trace[762687165] 'agreement among raft nodes before linearized reading' (duration: 668.679136ms)","trace[762687165] 'range keys from in-memory index tree' (duration: 158.975731ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:20:11.2178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:20:10.389066Z","time spent":"828.715395ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-18T22:20:11.217325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.316828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-aa5f8039-448b-406f-bfdf-788570f66990\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-18T22:20:11.217968Z","caller":"traceutil/trace.go:171","msg":"trace[965912546] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-aa5f8039-448b-406f-bfdf-788570f66990; range_end:; response_count:1; response_revision:1842; }","duration":"151.974625ms","start":"2026-04-18T22:20:11.065952Z","end":"2026-04-18T22:20:11.217927Z","steps":["trace[965912546] 'agreement among raft nodes before linearized reading' (duration: 151.242006ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:20:11.79881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.369242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-aa5f8039-448b-406f-bfdf-788570f66990\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-04-18T22:20:11.798885Z","caller":"traceutil/trace.go:171","msg":"trace[309384452] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-aa5f8039-448b-406f-bfdf-788570f66990; range_end:; response_count:1; response_revision:1844; }","duration":"220.482325ms","start":"2026-04-18T22:20:11.57838Z","end":"2026-04-18T22:20:11.798862Z","steps":["trace[309384452] 'range keys from in-memory index tree' (duration: 220.254819ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:20:11.800043Z","caller":"traceutil/trace.go:171","msg":"trace[1598498490] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"202.457109ms","start":"2026-04-18T22:20:11.59752Z","end":"2026-04-18T22:20:11.799977Z","steps":["trace[1598498490] 'process raft request' (duration: 154.992695ms)","trace[1598498490] 'compare' (duration: 46.785396ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:20:19.997263Z","caller":"traceutil/trace.go:171","msg":"trace[1403560428] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"160.438467ms","start":"2026-04-18T22:20:19.836797Z","end":"2026-04-18T22:20:19.997236Z","steps":["trace[1403560428] 'process raft request' (duration: 160.219622ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:20:25.460522Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581741517917258884,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-18T22:20:25.543394Z","caller":"traceutil/trace.go:171","msg":"trace[1434882058] transaction","detail":"{read_only:false; response_revision:1959; number_of_response:1; }","duration":"838.735579ms","start":"2026-04-18T22:20:24.704632Z","end":"2026-04-18T22:20:25.543368Z","steps":["trace[1434882058] 'process raft request' (duration: 838.532564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:20:25.543712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:20:24.704615Z","time spent":"838.999796ms","remote":"127.0.0.1:53850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5623,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:20:25.54432Z","caller":"traceutil/trace.go:171","msg":"trace[872419178] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"836.792588ms","start":"2026-04-18T22:20:24.707483Z","end":"2026-04-18T22:20:25.544276Z","steps":["trace[872419178] 'process raft request' (duration: 836.609082ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:20:25.54447Z","caller":"traceutil/trace.go:171","msg":"trace[1223503970] linearizableReadLoop","detail":"{readStateIndex:2032; appliedIndex:2029; }","duration":"584.653286ms","start":"2026-04-18T22:20:24.959787Z","end":"2026-04-18T22:20:25.54444Z","steps":["trace[1223503970] 'read index received' (duration: 583.409163ms)","trace[1223503970] 'applied index is now lower than readState.Index' (duration: 1.241483ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:20:25.544557Z","caller":"traceutil/trace.go:171","msg":"trace[131885405] transaction","detail":"{read_only:false; response_revision:1961; number_of_response:1; }","duration":"374.471583ms","start":"2026-04-18T22:20:25.170061Z","end":"2026-04-18T22:20:25.544533Z","steps":["trace[131885405] 'process raft request' (duration: 374.160485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:20:25.544621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:20:24.707366Z","time spent":"837.054384ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:20:25.544654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.8516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-18T22:20:25.54469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:20:25.170036Z","time spent":"374.585306ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:20:25.544715Z","caller":"traceutil/trace.go:171","msg":"trace[1173874448] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:1961; }","duration":"584.988344ms","start":"2026-04-18T22:20:24.959712Z","end":"2026-04-18T22:20:25.5447Z","steps":["trace[1173874448] 'agreement among raft nodes before linearized reading' (duration: 584.865341ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:20:25.544753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:20:24.959682Z","time spent":"585.061135ms","remote":"127.0.0.1:37748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":2,"response size":30,"request content":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:20:25.54496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.428344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:20:25.544987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.119839ms","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-04-18T22:20:25.545023Z","caller":"traceutil/trace.go:171","msg":"trace[429322078] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1961; }","duration":"177.18447ms","start":"2026-04-18T22:20:25.367829Z","end":"2026-04-18T22:20:25.545013Z","steps":["trace[429322078] 'agreement among raft nodes before linearized reading' (duration: 177.105268ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:20:25.545023Z","caller":"traceutil/trace.go:171","msg":"trace[205227352] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1961; }","duration":"111.539587ms","start":"2026-04-18T22:20:25.433468Z","end":"2026-04-18T22:20:25.545008Z","steps":["trace[205227352] 'agreement among raft nodes before linearized reading' (duration: 111.434904ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:20:25.545426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.822495ms","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-04-18T22:20:25.545456Z","caller":"traceutil/trace.go:171","msg":"trace[1539480916] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1961; }","duration":"229.446501ms","start":"2026-04-18T22:20:25.316002Z","end":"2026-04-18T22:20:25.545448Z","steps":["trace[1539480916] 'agreement among raft nodes before linearized reading' (duration: 228.833845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:20:28.300293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.677447ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:20:28.300442Z","caller":"traceutil/trace.go:171","msg":"trace[629559547] linearizableReadLoop","detail":"{readStateIndex:2058; appliedIndex:2056; }","duration":"127.083587ms","start":"2026-04-18T22:20:28.173347Z","end":"2026-04-18T22:20:28.300431Z","steps":["trace[629559547] 'read index received' (duration: 17.223985ms)","trace[629559547] 'applied index is now lower than readState.Index' (duration: 109.858781ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:20:28.300493Z","caller":"traceutil/trace.go:171","msg":"trace[1604936421] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"201.021202ms","start":"2026-04-18T22:20:28.099446Z","end":"2026-04-18T22:20:28.300467Z","steps":["trace[1604936421] 'process raft request' (duration: 200.927669ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:20:28.300577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.80828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-18T22:20:28.300592Z","caller":"traceutil/trace.go:171","msg":"trace[309212952] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1986; }","duration":"126.846031ms","start":"2026-04-18T22:20:28.173741Z","end":"2026-04-18T22:20:28.300587Z","steps":["trace[309212952] 'agreement among raft nodes before linearized reading' (duration: 126.762139ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:20:28.300659Z","caller":"traceutil/trace.go:171","msg":"trace[271466324] transaction","detail":"{read_only:false; response_revision:1985; number_of_response:1; }","duration":"203.737833ms","start":"2026-04-18T22:20:28.096895Z","end":"2026-04-18T22:20:28.300633Z","steps":["trace[271466324] 'process raft request' (duration: 93.657504ms)","trace[271466324] 'compare' (duration: 109.431091ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:20:28.30071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.326434ms","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-04-18T22:20:28.300816Z","caller":"traceutil/trace.go:171","msg":"trace[1552461084] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1986; }","duration":"127.465248ms","start":"2026-04-18T22:20:28.173328Z","end":"2026-04-18T22:20:28.300793Z","steps":["trace[1552461084] 'agreement among raft nodes before linearized reading' (duration: 127.174ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:20:56.563807Z","caller":"traceutil/trace.go:171","msg":"trace[379875011] linearizableReadLoop","detail":"{readStateIndex:2223; appliedIndex:2222; }","duration":"118.617284ms","start":"2026-04-18T22:20:56.445166Z","end":"2026-04-18T22:20:56.563784Z","steps":["trace[379875011] 'read index received' (duration: 118.531962ms)","trace[379875011] 'applied index is now lower than readState.Index' (duration: 84.402µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:20:56.563903Z","caller":"traceutil/trace.go:171","msg":"trace[1918165558] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"124.017622ms","start":"2026-04-18T22:20:56.439861Z","end":"2026-04-18T22:20:56.563879Z","steps":["trace[1918165558] 'process raft request' (duration: 123.794217ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:20:56.564121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.937143ms","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-04-18T22:20:56.564164Z","caller":"traceutil/trace.go:171","msg":"trace[2055350396] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2145; }","duration":"119.020385ms","start":"2026-04-18T22:20:56.445133Z","end":"2026-04-18T22:20:56.564153Z","steps":["trace[2055350396] 'agreement among raft nodes before linearized reading' (duration: 118.772208ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:20:56.606165Z","caller":"traceutil/trace.go:171","msg":"trace[614795754] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"160.209529ms","start":"2026-04-18T22:20:56.445918Z","end":"2026-04-18T22:20:56.606127Z","steps":["trace[614795754] 'process raft request' (duration: 160.098166ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:20:56.606657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.111852ms","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-04-18T22:20:56.606739Z","caller":"traceutil/trace.go:171","msg":"trace[237369030] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2146; }","duration":"100.250495ms","start":"2026-04-18T22:20:56.50647Z","end":"2026-04-18T22:20:56.606721Z","steps":["trace[237369030] 'agreement among raft nodes before linearized reading' (duration: 99.732612ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:21:02.485335Z","caller":"traceutil/trace.go:171","msg":"trace[929757557] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"256.232335ms","start":"2026-04-18T22:21:02.229079Z","end":"2026-04-18T22:21:02.485312Z","steps":["trace[929757557] 'process raft request' (duration: 256.080621ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:21:02.502759Z","caller":"traceutil/trace.go:171","msg":"trace[1852205663] linearizableReadLoop","detail":"{readStateIndex:2254; appliedIndex:2252; }","duration":"221.455325ms","start":"2026-04-18T22:21:02.281263Z","end":"2026-04-18T22:21:02.502718Z","steps":["trace[1852205663] 'read index received' (duration: 203.972238ms)","trace[1852205663] 'applied index is now lower than readState.Index' (duration: 17.481607ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:21:02.502969Z","caller":"traceutil/trace.go:171","msg":"trace[37735835] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"268.231352ms","start":"2026-04-18T22:21:02.234578Z","end":"2026-04-18T22:21:02.502809Z","steps":["trace[37735835] 'process raft request' (duration: 267.931255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:21:02.503167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.837235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-04-18T22:21:02.503219Z","caller":"traceutil/trace.go:171","msg":"trace[2084200067] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2175; }","duration":"221.981469ms","start":"2026-04-18T22:21:02.281225Z","end":"2026-04-18T22:21:02.503206Z","steps":["trace[2084200067] 'agreement among raft nodes before linearized reading' (duration: 221.64022ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:21:02.657744Z","caller":"traceutil/trace.go:171","msg":"trace[1343107927] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"150.209462ms","start":"2026-04-18T22:21:02.507503Z","end":"2026-04-18T22:21:02.657712Z","steps":["trace[1343107927] 'process raft request' (duration: 60.667902ms)","trace[1343107927] 'compare' (duration: 89.319344ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:21:02.657803Z","caller":"traceutil/trace.go:171","msg":"trace[290044714] linearizableReadLoop","detail":"{readStateIndex:2255; appliedIndex:2254; }","duration":"102.628516ms","start":"2026-04-18T22:21:02.55515Z","end":"2026-04-18T22:21:02.657779Z","steps":["trace[290044714] 'read index received' (duration: 13.014144ms)","trace[290044714] 'applied index is now lower than readState.Index' (duration: 89.613122ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:21:02.658126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.961843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T22:21:02.658207Z","caller":"traceutil/trace.go:171","msg":"trace[1616678524] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:2177; }","duration":"103.112877ms","start":"2026-04-18T22:21:02.555081Z","end":"2026-04-18T22:21:02.658194Z","steps":["trace[1616678524] 'agreement among raft nodes before linearized reading' (duration: 102.948613ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:21:03.197758Z","caller":"traceutil/trace.go:171","msg":"trace[1354675687] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"517.802416ms","start":"2026-04-18T22:21:02.679893Z","end":"2026-04-18T22:21:03.197696Z","steps":["trace[1354675687] 'process raft request' (duration: 425.362082ms)","trace[1354675687] 'compare' (duration: 92.070224ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:21:03.198225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:21:02.679876Z","time spent":"517.999581ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:21:04.024171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.868384ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:21:04.024321Z","caller":"traceutil/trace.go:171","msg":"trace[91838339] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2180; }","duration":"625.021699ms","start":"2026-04-18T22:21:03.399271Z","end":"2026-04-18T22:21:04.024293Z","steps":["trace[91838339] 'range keys from in-memory index tree' (duration: 624.845354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:21:04.024587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.713965ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:21:04.025078Z","caller":"traceutil/trace.go:171","msg":"trace[379949125] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"1.334063337s","start":"2026-04-18T22:21:02.690981Z","end":"2026-04-18T22:21:04.025044Z","steps":["trace[379949125] 'process raft request' (duration: 856.815478ms)","trace[379949125] 'compare' (duration: 476.286844ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:21:04.025122Z","caller":"traceutil/trace.go:171","msg":"trace[168142542] linearizableReadLoop","detail":"{readStateIndex:2260; appliedIndex:2258; }","duration":"1.212504878s","start":"2026-04-18T22:21:02.8126Z","end":"2026-04-18T22:21:04.025105Z","steps":["trace[168142542] 'read index received' (duration: 292.679577ms)","trace[168142542] 'applied index is now lower than readState.Index' (duration: 919.824351ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:21:04.025232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:21:02.690959Z","time spent":"1.334195011s","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:21:04.025362Z","caller":"traceutil/trace.go:171","msg":"trace[464575582] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"340.614933ms","start":"2026-04-18T22:21:03.684728Z","end":"2026-04-18T22:21:04.025343Z","steps":["trace[464575582] 'process raft request' (duration: 339.944076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:21:04.025478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:21:03.684709Z","time spent":"340.713255ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:21:04.025659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.21299629s","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-04-18T22:21:04.025709Z","caller":"traceutil/trace.go:171","msg":"trace[1749650260] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2182; }","duration":"1.213160154s","start":"2026-04-18T22:21:02.812534Z","end":"2026-04-18T22:21:04.025695Z","steps":["trace[1749650260] 'agreement among raft nodes before linearized reading' (duration: 1.212661641s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:21:04.025744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:21:02.812507Z","time spent":"1.213227866s","remote":"127.0.0.1:38582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-18T22:21:04.025827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.206698109s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:21:04.02591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.804465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T22:21:04.025927Z","caller":"traceutil/trace.go:171","msg":"trace[1035058492] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:2183; }","duration":"1.206847023s","start":"2026-04-18T22:21:02.819051Z","end":"2026-04-18T22:21:04.025898Z","steps":["trace[1035058492] 'agreement among raft nodes before linearized reading' (duration: 1.206656388s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:21:04.025948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.306625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:130286"} {"level":"info","ts":"2026-04-18T22:21:04.025969Z","caller":"traceutil/trace.go:171","msg":"trace[1157243913] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:2183; }","duration":"687.896637ms","start":"2026-04-18T22:21:03.338057Z","end":"2026-04-18T22:21:04.025954Z","steps":["trace[1157243913] 'agreement among raft nodes before linearized reading' (duration: 687.800305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:21:04.025983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.656695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a793933a67b97a\" ","response":"range_response_count:1 size:846"} {"level":"warn","ts":"2026-04-18T22:21:04.025992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:21:02.81903Z","time spent":"1.206944025s","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"info","ts":"2026-04-18T22:21:04.02601Z","caller":"traceutil/trace.go:171","msg":"trace[1520512621] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2183; }","duration":"175.398076ms","start":"2026-04-18T22:21:03.850594Z","end":"2026-04-18T22:21:04.025992Z","steps":["trace[1520512621] 'agreement among raft nodes before linearized reading' (duration: 175.190681ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:21:04.026024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:21:03.338035Z","time spent":"687.975289ms","remote":"127.0.0.1:53784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":9,"response size":30,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"info","ts":"2026-04-18T22:21:04.026043Z","caller":"traceutil/trace.go:171","msg":"trace[916114960] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18a793933a67b97a; range_end:; response_count:1; response_revision:2183; }","duration":"462.762928ms","start":"2026-04-18T22:21:03.563261Z","end":"2026-04-18T22:21:04.026023Z","steps":["trace[916114960] 'agreement among raft nodes before linearized reading' (duration: 462.582823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:21:04.026079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:21:03.563229Z","time spent":"462.8419ms","remote":"127.0.0.1:53760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":869,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a793933a67b97a\" "} {"level":"info","ts":"2026-04-18T22:21:04.026023Z","caller":"traceutil/trace.go:171","msg":"trace[605366114] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"338.424167ms","start":"2026-04-18T22:21:03.68757Z","end":"2026-04-18T22:21:04.025994Z","steps":["trace[605366114] 'process raft request' (duration: 337.720039ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:21:04.02614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.155906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12383"} {"level":"info","ts":"2026-04-18T22:21:04.026217Z","caller":"traceutil/trace.go:171","msg":"trace[280999053] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2183; }","duration":"142.250509ms","start":"2026-04-18T22:21:03.883945Z","end":"2026-04-18T22:21:04.026195Z","steps":["trace[280999053] 'agreement among raft nodes before linearized reading' (duration: 142.052494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:21:04.026248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.761813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-18T22:21:04.026126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.634671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"warn","ts":"2026-04-18T22:21:04.026272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:21:03.68752Z","time spent":"338.606461ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:21:04.02632Z","caller":"traceutil/trace.go:171","msg":"trace[784085057] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2183; }","duration":"173.884249ms","start":"2026-04-18T22:21:03.852421Z","end":"2026-04-18T22:21:04.026305Z","steps":["trace[784085057] 'agreement among raft nodes before linearized reading' (duration: 173.616541ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:21:04.026291Z","caller":"traceutil/trace.go:171","msg":"trace[1020934193] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2183; }","duration":"282.878317ms","start":"2026-04-18T22:21:03.7434Z","end":"2026-04-18T22:21:04.026279Z","steps":["trace[1020934193] 'agreement among raft nodes before linearized reading' (duration: 282.725102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:21:04.02648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.868282ms","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:5"} {"level":"info","ts":"2026-04-18T22:21:04.026706Z","caller":"traceutil/trace.go:171","msg":"trace[283114696] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:2183; }","duration":"336.55574ms","start":"2026-04-18T22:21:03.690031Z","end":"2026-04-18T22:21:04.026587Z","steps":["trace[283114696] 'agreement among raft nodes before linearized reading' (duration: 335.76915ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:21:04.026832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:21:03.690007Z","time spent":"336.805766ms","remote":"127.0.0.1:37730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true "} {"level":"info","ts":"2026-04-18T22:21:04.417333Z","caller":"traceutil/trace.go:171","msg":"trace[1615132065] linearizableReadLoop","detail":"{readStateIndex:2263; appliedIndex:2262; }","duration":"388.508398ms","start":"2026-04-18T22:21:04.028794Z","end":"2026-04-18T22:21:04.417302Z","steps":["trace[1615132065] 'read index received' (duration: 381.324755ms)","trace[1615132065] 'applied index is now lower than readState.Index' (duration: 7.181793ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:21:04.417674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.854097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:15 size:25783"} {"level":"info","ts":"2026-04-18T22:21:04.417719Z","caller":"traceutil/trace.go:171","msg":"trace[348353930] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:15; response_revision:2184; }","duration":"388.94436ms","start":"2026-04-18T22:21:04.028764Z","end":"2026-04-18T22:21:04.417708Z","steps":["trace[348353930] 'agreement among raft nodes before linearized reading' (duration: 388.672302ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:21:04.417755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:21:04.02875Z","time spent":"388.995981ms","remote":"127.0.0.1:53862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":15,"response size":25806,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" "} {"level":"info","ts":"2026-04-18T22:21:04.417656Z","caller":"traceutil/trace.go:171","msg":"trace[1324223172] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"388.962631ms","start":"2026-04-18T22:21:04.028658Z","end":"2026-04-18T22:21:04.417621Z","steps":["trace[1324223172] 'process raft request' (duration: 381.51215ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:21:04.418119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:21:04.028565Z","time spent":"389.409911ms","remote":"127.0.0.1:53760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:21:04.418818Z","caller":"traceutil/trace.go:171","msg":"trace[1141765011] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"388.374535ms","start":"2026-04-18T22:21:04.030427Z","end":"2026-04-18T22:21:04.418802Z","steps":["trace[1141765011] 'process raft request' (duration: 388.200861ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:21:04.418925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:21:04.030411Z","time spent":"388.440057ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:21:04.418898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.37859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"warn","ts":"2026-04-18T22:21:04.419004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.626219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:21:04.419089Z","caller":"traceutil/trace.go:171","msg":"trace[1182972002] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2185; }","duration":"384.725132ms","start":"2026-04-18T22:21:04.034348Z","end":"2026-04-18T22:21:04.419073Z","steps":["trace[1182972002] 'agreement among raft nodes before linearized reading' (duration: 384.559317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:21:04.41915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:21:04.034341Z","time spent":"384.798024ms","remote":"127.0.0.1:54104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-04-18T22:21:04.419008Z","caller":"traceutil/trace.go:171","msg":"trace[9548011] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2185; }","duration":"387.528923ms","start":"2026-04-18T22:21:04.031454Z","end":"2026-04-18T22:21:04.418983Z","steps":["trace[9548011] 'agreement among raft nodes before linearized reading' (duration: 387.326418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:21:04.419401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:21:04.031435Z","time spent":"387.931224ms","remote":"127.0.0.1:53756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":141,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"info","ts":"2026-04-18T22:21:49.951046Z","caller":"traceutil/trace.go:171","msg":"trace[1574060594] transaction","detail":"{read_only:false; response_revision:2599; number_of_response:1; }","duration":"159.248949ms","start":"2026-04-18T22:21:49.791767Z","end":"2026-04-18T22:21:49.951016Z","steps":["trace[1574060594] 'process raft request' (duration: 159.058635ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:21:53.667025Z","caller":"traceutil/trace.go:171","msg":"trace[1138541812] transaction","detail":"{read_only:false; response_revision:2624; number_of_response:1; }","duration":"207.832485ms","start":"2026-04-18T22:21:53.459172Z","end":"2026-04-18T22:21:53.667004Z","steps":["trace[1138541812] 'process raft request' (duration: 207.700932ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:21:53.689689Z","caller":"traceutil/trace.go:171","msg":"trace[648171606] linearizableReadLoop","detail":"{readStateIndex:2722; appliedIndex:2721; }","duration":"118.079043ms","start":"2026-04-18T22:21:53.571571Z","end":"2026-04-18T22:21:53.68965Z","steps":["trace[648171606] 'read index received' (duration: 95.710914ms)","trace[648171606] 'applied index is now lower than readState.Index' (duration: 22.365999ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:21:53.689903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.300529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:21:53.689883Z","caller":"traceutil/trace.go:171","msg":"trace[1168458349] transaction","detail":"{read_only:false; response_revision:2625; number_of_response:1; }","duration":"151.569565ms","start":"2026-04-18T22:21:53.538262Z","end":"2026-04-18T22:21:53.689832Z","steps":["trace[1168458349] 'process raft request' (duration: 151.164515ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:21:53.690005Z","caller":"traceutil/trace.go:171","msg":"trace[53656971] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2625; }","duration":"118.403901ms","start":"2026-04-18T22:21:53.571551Z","end":"2026-04-18T22:21:53.689955Z","steps":["trace[53656971] 'agreement among raft nodes before linearized reading' (duration: 118.267128ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:22:27.327448Z","caller":"traceutil/trace.go:171","msg":"trace[184057767] linearizableReadLoop","detail":"{readStateIndex:2933; appliedIndex:2932; }","duration":"205.148317ms","start":"2026-04-18T22:22:27.122249Z","end":"2026-04-18T22:22:27.327397Z","steps":["trace[184057767] 'read index received' (duration: 204.927361ms)","trace[184057767] 'applied index is now lower than readState.Index' (duration: 219.956µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:22:27.327516Z","caller":"traceutil/trace.go:171","msg":"trace[784828944] transaction","detail":"{read_only:false; response_revision:2828; number_of_response:1; }","duration":"212.73758ms","start":"2026-04-18T22:22:27.114724Z","end":"2026-04-18T22:22:27.327462Z","steps":["trace[784828944] 'process raft request' (duration: 212.499225ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:22:27.327727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.463926ms","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-04-18T22:22:27.327762Z","caller":"traceutil/trace.go:171","msg":"trace[1392132191] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2828; }","duration":"205.584658ms","start":"2026-04-18T22:22:27.122169Z","end":"2026-04-18T22:22:27.327753Z","steps":["trace[1392132191] 'agreement among raft nodes before linearized reading' (duration: 205.419493ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:22:27.327794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.499698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:22:27.327928Z","caller":"traceutil/trace.go:171","msg":"trace[1882786689] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:2828; }","duration":"104.716674ms","start":"2026-04-18T22:22:27.223185Z","end":"2026-04-18T22:22:27.327901Z","steps":["trace[1882786689] 'agreement among raft nodes before linearized reading' (duration: 104.454358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:22:27.691981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.066078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:22:27.692086Z","caller":"traceutil/trace.go:171","msg":"trace[301279849] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2829; }","duration":"119.249012ms","start":"2026-04-18T22:22:27.572814Z","end":"2026-04-18T22:22:27.692063Z","steps":["trace[301279849] 'range keys from in-memory index tree' (duration: 118.923285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:22:28.235358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.049302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/valkey-node-0.18a793a8126e21d0\" ","response":"range_response_count:1 size:765"} {"level":"info","ts":"2026-04-18T22:22:28.235498Z","caller":"traceutil/trace.go:171","msg":"trace[142549545] range","detail":"{range_begin:/registry/events/openstack/valkey-node-0.18a793a8126e21d0; range_end:; response_count:1; response_revision:2830; }","duration":"153.278028ms","start":"2026-04-18T22:22:28.082194Z","end":"2026-04-18T22:22:28.235472Z","steps":["trace[142549545] 'range keys from in-memory index tree' (duration: 152.779604ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:25:03.783212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.448344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:25:03.783354Z","caller":"traceutil/trace.go:171","msg":"trace[1319280410] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3852; }","duration":"210.64873ms","start":"2026-04-18T22:25:03.572682Z","end":"2026-04-18T22:25:03.783331Z","steps":["trace[1319280410] 'range keys from in-memory index tree' (duration: 210.326142ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:26:27.987906Z","caller":"traceutil/trace.go:171","msg":"trace[844680233] transaction","detail":"{read_only:false; response_revision:4893; number_of_response:1; }","duration":"533.426019ms","start":"2026-04-18T22:26:27.454444Z","end":"2026-04-18T22:26:27.98787Z","steps":["trace[844680233] 'process raft request' (duration: 533.289626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:26:27.988063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:26:27.45441Z","time spent":"533.561855ms","remote":"127.0.0.1:53850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14481,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:26:27.995544Z","caller":"traceutil/trace.go:171","msg":"trace[1565653442] linearizableReadLoop","detail":"{readStateIndex:5077; appliedIndex:5075; }","duration":"238.721501ms","start":"2026-04-18T22:26:27.756807Z","end":"2026-04-18T22:26:27.995528Z","steps":["trace[1565653442] 'read index received' (duration: 231.06665ms)","trace[1565653442] 'applied index is now lower than readState.Index' (duration: 7.653921ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:26:27.995593Z","caller":"traceutil/trace.go:171","msg":"trace[2144721545] transaction","detail":"{read_only:false; response_revision:4895; number_of_response:1; }","duration":"291.261489ms","start":"2026-04-18T22:26:27.70432Z","end":"2026-04-18T22:26:27.995581Z","steps":["trace[2144721545] 'process raft request' (duration: 291.163446ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:26:27.99562Z","caller":"traceutil/trace.go:171","msg":"trace[1437568535] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"332.093509ms","start":"2026-04-18T22:26:27.66348Z","end":"2026-04-18T22:26:27.995574Z","steps":["trace[1437568535] 'process raft request' (duration: 331.860284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:26:27.99573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.891916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:26:27.995811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:26:27.663384Z","time spent":"332.323937ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:26:27.995836Z","caller":"traceutil/trace.go:171","msg":"trace[383303209] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:4895; }","duration":"239.04556ms","start":"2026-04-18T22:26:27.756753Z","end":"2026-04-18T22:26:27.995799Z","steps":["trace[383303209] 'agreement among raft nodes before linearized reading' (duration: 238.868996ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:26:28.01324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.243694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:26:28.013315Z","caller":"traceutil/trace.go:171","msg":"trace[7911202] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:4896; }","duration":"165.326246ms","start":"2026-04-18T22:26:27.847968Z","end":"2026-04-18T22:26:28.013294Z","steps":["trace[7911202] 'agreement among raft nodes before linearized reading' (duration: 165.154841ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:26:28.013422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.92643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-18T22:26:28.01356Z","caller":"traceutil/trace.go:171","msg":"trace[1200427314] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4896; }","duration":"185.126205ms","start":"2026-04-18T22:26:27.828405Z","end":"2026-04-18T22:26:28.013532Z","steps":["trace[1200427314] 'agreement among raft nodes before linearized reading' (duration: 184.673362ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:26:30.430398Z","caller":"traceutil/trace.go:171","msg":"trace[1654739039] transaction","detail":"{read_only:false; response_revision:5024; number_of_response:1; }","duration":"143.489443ms","start":"2026-04-18T22:26:30.286875Z","end":"2026-04-18T22:26:30.430364Z","steps":["trace[1654739039] 'process raft request' (duration: 143.266148ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:26:42.235658Z","caller":"traceutil/trace.go:171","msg":"trace[1756056470] transaction","detail":"{read_only:false; response_revision:5247; number_of_response:1; }","duration":"221.538751ms","start":"2026-04-18T22:26:42.01409Z","end":"2026-04-18T22:26:42.235629Z","steps":["trace[1756056470] 'process raft request' (duration: 221.243712ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:26:42.255769Z","caller":"traceutil/trace.go:171","msg":"trace[1243379620] transaction","detail":"{read_only:false; response_revision:5248; number_of_response:1; }","duration":"209.293239ms","start":"2026-04-18T22:26:42.046441Z","end":"2026-04-18T22:26:42.255735Z","steps":["trace[1243379620] 'process raft request' (duration: 209.028993ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:26:42.255904Z","caller":"traceutil/trace.go:171","msg":"trace[1618261205] linearizableReadLoop","detail":"{readStateIndex:5441; appliedIndex:5438; }","duration":"163.177171ms","start":"2026-04-18T22:26:42.092703Z","end":"2026-04-18T22:26:42.25588Z","steps":["trace[1618261205] 'read index received' (duration: 142.622001ms)","trace[1618261205] 'applied index is now lower than readState.Index' (duration: 20.55317ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:26:42.256029Z","caller":"traceutil/trace.go:171","msg":"trace[404906498] transaction","detail":"{read_only:false; response_revision:5249; number_of_response:1; }","duration":"209.500865ms","start":"2026-04-18T22:26:42.046475Z","end":"2026-04-18T22:26:42.255976Z","steps":["trace[404906498] 'process raft request' (duration: 209.211707ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:26:42.256122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.393966ms","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-04-18T22:26:42.256193Z","caller":"traceutil/trace.go:171","msg":"trace[1875334990] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5249; }","duration":"163.482558ms","start":"2026-04-18T22:26:42.092688Z","end":"2026-04-18T22:26:42.256171Z","steps":["trace[1875334990] 'agreement among raft nodes before linearized reading' (duration: 163.281973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:26:42.469824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.234666ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:26:42.470059Z","caller":"traceutil/trace.go:171","msg":"trace[204512906] transaction","detail":"{read_only:false; response_revision:5251; number_of_response:1; }","duration":"208.762695ms","start":"2026-04-18T22:26:42.261279Z","end":"2026-04-18T22:26:42.470042Z","steps":["trace[204512906] 'process raft request' (duration: 208.660762ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:26:42.470011Z","caller":"traceutil/trace.go:171","msg":"trace[1288328255] transaction","detail":"{read_only:false; response_revision:5250; number_of_response:1; }","duration":"232.422446ms","start":"2026-04-18T22:26:42.23751Z","end":"2026-04-18T22:26:42.469933Z","steps":["trace[1288328255] 'process raft request' (duration: 102.011966ms)","trace[1288328255] 'compare' (duration: 129.928848ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:26:42.470081Z","caller":"traceutil/trace.go:171","msg":"trace[1464582914] linearizableReadLoop","detail":"{readStateIndex:5442; appliedIndex:5441; }","duration":"214.052744ms","start":"2026-04-18T22:26:42.255946Z","end":"2026-04-18T22:26:42.469999Z","steps":["trace[1464582914] 'read index received' (duration: 83.714776ms)","trace[1464582914] 'applied index is now lower than readState.Index' (duration: 130.335938ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:26:42.470306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.471328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:26:42.470307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.80871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-xp67g\" ","response":"range_response_count:1 size:7818"} {"level":"info","ts":"2026-04-18T22:26:42.470346Z","caller":"traceutil/trace.go:171","msg":"trace[58796606] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:5251; }","duration":"176.576541ms","start":"2026-04-18T22:26:42.293758Z","end":"2026-04-18T22:26:42.470334Z","steps":["trace[58796606] 'agreement among raft nodes before linearized reading' (duration: 176.491509ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:26:42.470389Z","caller":"traceutil/trace.go:171","msg":"trace[1534029845] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-xp67g; range_end:; response_count:1; response_revision:5251; }","duration":"239.984584ms","start":"2026-04-18T22:26:42.230381Z","end":"2026-04-18T22:26:42.470365Z","steps":["trace[1534029845] 'agreement among raft nodes before linearized reading' (duration: 239.731118ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:26:42.937593Z","caller":"traceutil/trace.go:171","msg":"trace[932568118] transaction","detail":"{read_only:false; response_revision:5255; number_of_response:1; }","duration":"368.984587ms","start":"2026-04-18T22:26:42.56855Z","end":"2026-04-18T22:26:42.937535Z","steps":["trace[932568118] 'process raft request' (duration: 268.980674ms)","trace[932568118] 'compare' (duration: 98.792041ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:26:42.937691Z","caller":"traceutil/trace.go:171","msg":"trace[1068900792] transaction","detail":"{read_only:false; response_revision:5256; number_of_response:1; }","duration":"365.828874ms","start":"2026-04-18T22:26:42.571736Z","end":"2026-04-18T22:26:42.937565Z","steps":["trace[1068900792] 'process raft request' (duration: 365.625119ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:26:42.937837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:26:42.571713Z","time spent":"366.030821ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:26:42.937837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:26:42.568517Z","time spent":"369.200763ms","remote":"127.0.0.1:53760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":891,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:26:42.938032Z","caller":"traceutil/trace.go:171","msg":"trace[854870643] transaction","detail":"{read_only:false; response_revision:5259; number_of_response:1; }","duration":"365.344992ms","start":"2026-04-18T22:26:42.572651Z","end":"2026-04-18T22:26:42.937996Z","steps":["trace[854870643] 'process raft request' (duration: 365.25832ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:26:42.938118Z","caller":"traceutil/trace.go:171","msg":"trace[1481705377] transaction","detail":"{read_only:false; response_revision:5257; number_of_response:1; }","duration":"366.247656ms","start":"2026-04-18T22:26:42.571839Z","end":"2026-04-18T22:26:42.938087Z","steps":["trace[1481705377] 'process raft request' (duration: 365.64698ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:26:42.938224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:26:42.572624Z","time spent":"365.498536ms","remote":"127.0.0.1:53940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1068,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:26:42.938304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:26:42.571802Z","time spent":"366.41007ms","remote":"127.0.0.1:53834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":530,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:26:42.938467Z","caller":"traceutil/trace.go:171","msg":"trace[1532970691] transaction","detail":"{read_only:false; response_revision:5258; number_of_response:1; }","duration":"365.903097ms","start":"2026-04-18T22:26:42.572552Z","end":"2026-04-18T22:26:42.938455Z","steps":["trace[1532970691] 'process raft request' (duration: 365.207819ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:26:42.938526Z","caller":"traceutil/trace.go:171","msg":"trace[323344299] linearizableReadLoop","detail":"{readStateIndex:5449; appliedIndex:5446; }","duration":"366.284238ms","start":"2026-04-18T22:26:42.57223Z","end":"2026-04-18T22:26:42.938514Z","steps":["trace[323344299] 'read index received' (duration: 265.34788ms)","trace[323344299] 'applied index is now lower than readState.Index' (duration: 100.935178ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:26:42.938553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:26:42.572525Z","time spent":"365.99319ms","remote":"127.0.0.1:53834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":682,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:26:42.938603Z","caller":"traceutil/trace.go:171","msg":"trace[226900136] transaction","detail":"{read_only:false; response_revision:5260; number_of_response:1; }","duration":"365.186859ms","start":"2026-04-18T22:26:42.57337Z","end":"2026-04-18T22:26:42.938557Z","steps":["trace[226900136] 'process raft request' (duration: 364.591243ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:26:42.938674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.442821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:26:42.938719Z","caller":"traceutil/trace.go:171","msg":"trace[2064393667] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5260; }","duration":"366.522734ms","start":"2026-04-18T22:26:42.572185Z","end":"2026-04-18T22:26:42.938707Z","steps":["trace[2064393667] 'agreement among raft nodes before linearized reading' (duration: 366.433661ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:26:42.938755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:26:42.572173Z","time spent":"366.575995ms","remote":"127.0.0.1:53676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T22:26:42.938759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:26:42.573357Z","time spent":"365.330622ms","remote":"127.0.0.1:53940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1039,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:26:42.939029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.216558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/vector-mvrpz\" ","response":"range_response_count:1 size:5852"} {"level":"warn","ts":"2026-04-18T22:26:42.939042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.961244ms","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-04-18T22:26:42.939085Z","caller":"traceutil/trace.go:171","msg":"trace[46224644] range","detail":"{range_begin:/registry/pods/monitoring/vector-mvrpz; range_end:; response_count:1; response_revision:5260; }","duration":"365.301311ms","start":"2026-04-18T22:26:42.573768Z","end":"2026-04-18T22:26:42.93907Z","steps":["trace[46224644] 'agreement among raft nodes before linearized reading' (duration: 365.077885ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:26:42.939325Z","caller":"traceutil/trace.go:171","msg":"trace[123208436] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5260; }","duration":"208.193421ms","start":"2026-04-18T22:26:42.731033Z","end":"2026-04-18T22:26:42.939227Z","steps":["trace[123208436] 'agreement among raft nodes before linearized reading' (duration: 207.853822ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:26:42.939141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.837202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:26:42.939395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:26:42.573757Z","time spent":"365.618429ms","remote":"127.0.0.1:53850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":5875,"request content":"key:\"/registry/pods/monitoring/vector-mvrpz\" "} {"level":"info","ts":"2026-04-18T22:26:42.939492Z","caller":"traceutil/trace.go:171","msg":"trace[1136141896] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:5260; }","duration":"245.210191ms","start":"2026-04-18T22:26:42.694257Z","end":"2026-04-18T22:26:42.939467Z","steps":["trace[1136141896] 'agreement among raft nodes before linearized reading' (duration: 244.848511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:26:42.939157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.859078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kj64n\" ","response":"range_response_count:1 size:6522"} {"level":"info","ts":"2026-04-18T22:26:42.939711Z","caller":"traceutil/trace.go:171","msg":"trace[2128851605] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kj64n; range_end:; response_count:1; response_revision:5260; }","duration":"132.461864ms","start":"2026-04-18T22:26:42.807224Z","end":"2026-04-18T22:26:42.939685Z","steps":["trace[2128851605] 'agreement among raft nodes before linearized reading' (duration: 131.803816ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:26:42.939266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.243558ms","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-04-18T22:26:42.940639Z","caller":"traceutil/trace.go:171","msg":"trace[1110874122] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5260; }","duration":"213.767768ms","start":"2026-04-18T22:26:42.726849Z","end":"2026-04-18T22:26:42.940617Z","steps":["trace[1110874122] 'agreement among raft nodes before linearized reading' (duration: 212.107724ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:26:50.646026Z","caller":"traceutil/trace.go:171","msg":"trace[2018527596] transaction","detail":"{read_only:false; response_revision:5426; number_of_response:1; }","duration":"132.386332ms","start":"2026-04-18T22:26:50.51359Z","end":"2026-04-18T22:26:50.645976Z","steps":["trace[2018527596] 'process raft request' (duration: 57.670052ms)","trace[2018527596] 'compare' (duration: 74.429272ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:26:51.090746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.981376ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-18T22:26:51.09086Z","caller":"traceutil/trace.go:171","msg":"trace[1763968301] linearizableReadLoop","detail":"{readStateIndex:5624; appliedIndex:5623; }","duration":"109.495871ms","start":"2026-04-18T22:26:50.981345Z","end":"2026-04-18T22:26:51.090841Z","steps":["trace[1763968301] 'read index received' (duration: 52.231µs)","trace[1763968301] 'applied index is now lower than readState.Index' (duration: 109.44194ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:26:51.091124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.770018ms","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-04-18T22:26:51.091187Z","caller":"traceutil/trace.go:171","msg":"trace[585536490] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5426; }","duration":"109.882411ms","start":"2026-04-18T22:26:50.98129Z","end":"2026-04-18T22:26:51.091172Z","steps":["trace[585536490] 'agreement among raft nodes before linearized reading' (duration: 109.663235ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:26:51.091376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.30238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-18T22:26:51.09141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.177645ms","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-04-18T22:26:51.091487Z","caller":"traceutil/trace.go:171","msg":"trace[1423365382] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5426; }","duration":"100.464524ms","start":"2026-04-18T22:26:50.991003Z","end":"2026-04-18T22:26:51.091468Z","steps":["trace[1423365382] 'agreement among raft nodes before linearized reading' (duration: 100.143536ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:26:51.091524Z","caller":"traceutil/trace.go:171","msg":"trace[611990961] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5426; }","duration":"106.333958ms","start":"2026-04-18T22:26:50.985169Z","end":"2026-04-18T22:26:51.091503Z","steps":["trace[611990961] 'agreement among raft nodes before linearized reading' (duration: 105.956699ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:26:51.307598Z","caller":"traceutil/trace.go:171","msg":"trace[275818459] transaction","detail":"{read_only:false; response_revision:5427; number_of_response:1; }","duration":"211.487747ms","start":"2026-04-18T22:26:51.096091Z","end":"2026-04-18T22:26:51.307579Z","steps":["trace[275818459] 'process raft request' (duration: 211.345713ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:26:51.542546Z","caller":"traceutil/trace.go:171","msg":"trace[1845906764] linearizableReadLoop","detail":"{readStateIndex:5627; appliedIndex:5624; }","duration":"237.774055ms","start":"2026-04-18T22:26:51.304745Z","end":"2026-04-18T22:26:51.542519Z","steps":["trace[1845906764] 'read index received' (duration: 2.768652ms)","trace[1845906764] 'applied index is now lower than readState.Index' (duration: 235.003553ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:26:51.542833Z","caller":"traceutil/trace.go:171","msg":"trace[975835524] transaction","detail":"{read_only:false; response_revision:5429; number_of_response:1; }","duration":"446.215114ms","start":"2026-04-18T22:26:51.0966Z","end":"2026-04-18T22:26:51.542815Z","steps":["trace[975835524] 'process raft request' (duration: 445.854064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:26:51.543203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:26:51.09659Z","time spent":"446.522701ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:26:51.542583Z","caller":"traceutil/trace.go:171","msg":"trace[1770191362] transaction","detail":"{read_only:false; response_revision:5428; number_of_response:1; }","duration":"446.027888ms","start":"2026-04-18T22:26:51.096518Z","end":"2026-04-18T22:26:51.542546Z","steps":["trace[1770191362] 'process raft request' (duration: 434.005473ms)","trace[1770191362] 'compare' (duration: 11.743848ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:26:51.542945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.180937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T22:26:51.543804Z","caller":"traceutil/trace.go:171","msg":"trace[645338879] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:5429; }","duration":"239.08165ms","start":"2026-04-18T22:26:51.304701Z","end":"2026-04-18T22:26:51.543783Z","steps":["trace[645338879] 'agreement among raft nodes before linearized reading' (duration: 238.160716ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:26:51.54406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:26:51.096501Z","time spent":"447.20739ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:26:51.552906Z","caller":"traceutil/trace.go:171","msg":"trace[985881660] transaction","detail":"{read_only:false; response_revision:5430; number_of_response:1; }","duration":"242.620543ms","start":"2026-04-18T22:26:51.310276Z","end":"2026-04-18T22:26:51.552897Z","steps":["trace[985881660] 'process raft request' (duration: 242.52392ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:26:51.553411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.375994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-04-18T22:26:51.553556Z","caller":"traceutil/trace.go:171","msg":"trace[106515801] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5432; }","duration":"150.520418ms","start":"2026-04-18T22:26:51.403026Z","end":"2026-04-18T22:26:51.553546Z","steps":["trace[106515801] 'agreement among raft nodes before linearized reading' (duration: 150.297032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:26:51.553403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.38064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/loki-0\" ","response":"range_response_count:1 size:5588"} {"level":"info","ts":"2026-04-18T22:26:51.553766Z","caller":"traceutil/trace.go:171","msg":"trace[1168419907] range","detail":"{range_begin:/registry/pods/monitoring/loki-0; range_end:; response_count:1; response_revision:5432; }","duration":"220.79237ms","start":"2026-04-18T22:26:51.332946Z","end":"2026-04-18T22:26:51.553738Z","steps":["trace[1168419907] 'agreement among raft nodes before linearized reading' (duration: 220.279618ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:26:51.74416Z","caller":"traceutil/trace.go:171","msg":"trace[5584608] linearizableReadLoop","detail":"{readStateIndex:5631; appliedIndex:5630; }","duration":"172.585957ms","start":"2026-04-18T22:26:51.571519Z","end":"2026-04-18T22:26:51.744105Z","steps":["trace[5584608] 'read index received' (duration: 169.771983ms)","trace[5584608] 'applied index is now lower than readState.Index' (duration: 2.812573ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:26:51.74425Z","caller":"traceutil/trace.go:171","msg":"trace[53467445] transaction","detail":"{read_only:false; response_revision:5433; number_of_response:1; }","duration":"182.59262ms","start":"2026-04-18T22:26:51.561635Z","end":"2026-04-18T22:26:51.744228Z","steps":["trace[53467445] 'process raft request' (duration: 179.780816ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:26:51.744349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.818433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:26:51.744399Z","caller":"traceutil/trace.go:171","msg":"trace[892902656] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5433; }","duration":"172.908476ms","start":"2026-04-18T22:26:51.57148Z","end":"2026-04-18T22:26:51.744389Z","steps":["trace[892902656] 'agreement among raft nodes before linearized reading' (duration: 172.811203ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:26:51.74458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.309096ms","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-04-18T22:26:51.74469Z","caller":"traceutil/trace.go:171","msg":"trace[1246281624] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5433; }","duration":"141.4702ms","start":"2026-04-18T22:26:51.603195Z","end":"2026-04-18T22:26:51.744665Z","steps":["trace[1246281624] 'agreement among raft nodes before linearized reading' (duration: 141.166593ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:28:02.630511Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3021} {"level":"info","ts":"2026-04-18T22:28:02.717526Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3021,"took":"84.913561ms","hash":2473603136,"current-db-size-bytes":58441728,"current-db-size":"58 MB","current-db-size-in-use-bytes":31580160,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-18T22:28:02.717711Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2473603136,"revision":3021,"compact-revision":-1} {"level":"info","ts":"2026-04-18T22:33:02.637748Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6095} {"level":"info","ts":"2026-04-18T22:33:02.74832Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6095,"took":"108.124547ms","hash":696911591,"current-db-size-bytes":58441728,"current-db-size":"58 MB","current-db-size-in-use-bytes":23244800,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-18T22:33:02.748407Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":696911591,"revision":6095,"compact-revision":3021} {"level":"info","ts":"2026-04-18T22:33:05.735196Z","caller":"traceutil/trace.go:171","msg":"trace[1991091857] linearizableReadLoop","detail":"{readStateIndex:8591; appliedIndex:8590; }","duration":"278.77584ms","start":"2026-04-18T22:33:05.456379Z","end":"2026-04-18T22:33:05.735155Z","steps":["trace[1991091857] 'read index received' (duration: 278.552665ms)","trace[1991091857] 'applied index is now lower than readState.Index' (duration: 221.785µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:33:05.735555Z","caller":"traceutil/trace.go:171","msg":"trace[155081791] transaction","detail":"{read_only:false; response_revision:8304; number_of_response:1; }","duration":"302.032308ms","start":"2026-04-18T22:33:05.433498Z","end":"2026-04-18T22:33:05.73553Z","steps":["trace[155081791] 'process raft request' (duration: 301.441643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:33:05.735657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.532863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:33:05.735798Z","caller":"traceutil/trace.go:171","msg":"trace[2062696202] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8304; }","duration":"160.739498ms","start":"2026-04-18T22:33:05.575026Z","end":"2026-04-18T22:33:05.735765Z","steps":["trace[2062696202] 'agreement among raft nodes before linearized reading' (duration: 160.501142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:33:05.735895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.82161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.233\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-04-18T22:33:05.735717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.279883ms","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-04-18T22:33:05.735943Z","caller":"traceutil/trace.go:171","msg":"trace[1526777352] range","detail":"{range_begin:/registry/masterleases/199.204.45.233; range_end:; response_count:1; response_revision:8304; }","duration":"153.888182ms","start":"2026-04-18T22:33:05.582043Z","end":"2026-04-18T22:33:05.735932Z","steps":["trace[1526777352] 'agreement among raft nodes before linearized reading' (duration: 153.707448ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:33:05.735959Z","caller":"traceutil/trace.go:171","msg":"trace[464180963] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8304; }","duration":"279.638402ms","start":"2026-04-18T22:33:05.456302Z","end":"2026-04-18T22:33:05.735941Z","steps":["trace[464180963] 'agreement among raft nodes before linearized reading' (duration: 279.168281ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:33:05.735708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:33:05.433473Z","time spent":"302.125411ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:33:05.735937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.660148ms","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-04-18T22:33:05.73607Z","caller":"traceutil/trace.go:171","msg":"trace[841452836] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:8304; }","duration":"155.873404ms","start":"2026-04-18T22:33:05.580167Z","end":"2026-04-18T22:33:05.73604Z","steps":["trace[841452836] 'agreement among raft nodes before linearized reading' (duration: 155.625787ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:33:05.91659Z","caller":"traceutil/trace.go:171","msg":"trace[1457190192] transaction","detail":"{read_only:false; response_revision:8305; number_of_response:1; }","duration":"174.776698ms","start":"2026-04-18T22:33:05.741782Z","end":"2026-04-18T22:33:05.916558Z","steps":["trace[1457190192] 'process raft request' (duration: 174.343298ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:33:05.916841Z","caller":"traceutil/trace.go:171","msg":"trace[326695724] transaction","detail":"{read_only:false; response_revision:8306; number_of_response:1; }","duration":"174.566565ms","start":"2026-04-18T22:33:05.742253Z","end":"2026-04-18T22:33:05.916819Z","steps":["trace[326695724] 'process raft request' (duration: 173.99902ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:33:05.917009Z","caller":"traceutil/trace.go:171","msg":"trace[1949203233] transaction","detail":"{read_only:false; response_revision:8309; number_of_response:1; }","duration":"104.106114ms","start":"2026-04-18T22:33:05.812893Z","end":"2026-04-18T22:33:05.916999Z","steps":["trace[1949203233] 'process raft request' (duration: 103.622501ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:33:05.91703Z","caller":"traceutil/trace.go:171","msg":"trace[385629523] transaction","detail":"{read_only:false; response_revision:8308; number_of_response:1; }","duration":"116.119323ms","start":"2026-04-18T22:33:05.800864Z","end":"2026-04-18T22:33:05.916983Z","steps":["trace[385629523] 'process raft request' (duration: 115.458206ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:33:05.917111Z","caller":"traceutil/trace.go:171","msg":"trace[806177252] transaction","detail":"{read_only:false; response_revision:8307; number_of_response:1; }","duration":"174.114922ms","start":"2026-04-18T22:33:05.742977Z","end":"2026-04-18T22:33:05.917092Z","steps":["trace[806177252] 'process raft request' (duration: 173.308982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:33:17.472207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.061491ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:33:17.472703Z","caller":"traceutil/trace.go:171","msg":"trace[367084464] transaction","detail":"{read_only:false; response_revision:8368; number_of_response:1; }","duration":"365.465077ms","start":"2026-04-18T22:33:17.107216Z","end":"2026-04-18T22:33:17.472681Z","steps":["trace[367084464] 'process raft request' (duration: 365.083787ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:33:17.472783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:33:17.107181Z","time spent":"365.56397ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:33:17.472755Z","caller":"traceutil/trace.go:171","msg":"trace[1568979945] transaction","detail":"{read_only:false; response_revision:8367; number_of_response:1; }","duration":"457.801569ms","start":"2026-04-18T22:33:17.014894Z","end":"2026-04-18T22:33:17.472696Z","steps":["trace[1568979945] 'process raft request' (duration: 274.153952ms)","trace[1568979945] 'compare' (duration: 182.936938ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:33:17.473099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:33:17.014872Z","time spent":"458.019914ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:33:18.524608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.488224ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:33:18.524753Z","caller":"traceutil/trace.go:171","msg":"trace[399317653] linearizableReadLoop","detail":"{readStateIndex:8661; appliedIndex:8660; }","duration":"511.18202ms","start":"2026-04-18T22:33:18.013547Z","end":"2026-04-18T22:33:18.524729Z","steps":["trace[399317653] 'read index received' (duration: 397.52833ms)","trace[399317653] 'applied index is now lower than readState.Index' (duration: 113.65169ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:33:18.524804Z","caller":"traceutil/trace.go:171","msg":"trace[1413228648] transaction","detail":"{read_only:false; response_revision:8371; number_of_response:1; }","duration":"511.332084ms","start":"2026-04-18T22:33:18.013428Z","end":"2026-04-18T22:33:18.52476Z","steps":["trace[1413228648] 'process raft request' (duration: 397.566802ms)","trace[1413228648] 'compare' (duration: 113.346851ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:33:18.524932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.382164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-04-18T22:33:18.524973Z","caller":"traceutil/trace.go:171","msg":"trace[1119523424] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8371; }","duration":"511.481578ms","start":"2026-04-18T22:33:18.013481Z","end":"2026-04-18T22:33:18.524963Z","steps":["trace[1119523424] 'agreement among raft nodes before linearized reading' (duration: 511.334815ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:33:18.525013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:33:18.013452Z","time spent":"511.547889ms","remote":"127.0.0.1:53850","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-04-18T22:33:18.525089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:33:18.013405Z","time spent":"511.484729ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:33:18.53607Z","caller":"traceutil/trace.go:171","msg":"trace[294176873] transaction","detail":"{read_only:false; response_revision:8373; number_of_response:1; }","duration":"522.328367ms","start":"2026-04-18T22:33:18.013729Z","end":"2026-04-18T22:33:18.536057Z","steps":["trace[294176873] 'process raft request' (duration: 522.278905ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:33:18.536072Z","caller":"traceutil/trace.go:171","msg":"trace[1449415919] transaction","detail":"{read_only:false; response_revision:8372; number_of_response:1; }","duration":"522.397288ms","start":"2026-04-18T22:33:18.013649Z","end":"2026-04-18T22:33:18.536046Z","steps":["trace[1449415919] 'process raft request' (duration: 522.257065ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:33:18.536138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:33:18.013682Z","time spent":"522.426029ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:33:18.536196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:33:18.013623Z","time spent":"522.50348ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:33:18.536307Z","caller":"traceutil/trace.go:171","msg":"trace[1728849840] transaction","detail":"{read_only:false; response_revision:8374; number_of_response:1; }","duration":"522.408818ms","start":"2026-04-18T22:33:18.013837Z","end":"2026-04-18T22:33:18.536246Z","steps":["trace[1728849840] 'process raft request' (duration: 522.195363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:33:18.536349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:33:18.01381Z","time spent":"522.513911ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:33:18.536531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.690014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"} {"level":"info","ts":"2026-04-18T22:33:18.536604Z","caller":"traceutil/trace.go:171","msg":"trace[930275988] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8374; }","duration":"300.795306ms","start":"2026-04-18T22:33:18.235787Z","end":"2026-04-18T22:33:18.536583Z","steps":["trace[930275988] 'agreement among raft nodes before linearized reading' (duration: 300.617941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:33:18.53664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:33:18.235764Z","time spent":"300.867878ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":551,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"info","ts":"2026-04-18T22:33:19.590974Z","caller":"traceutil/trace.go:171","msg":"trace[128265449] transaction","detail":"{read_only:false; response_revision:8378; number_of_response:1; }","duration":"112.10953ms","start":"2026-04-18T22:33:19.478841Z","end":"2026-04-18T22:33:19.590951Z","steps":["trace[128265449] 'process raft request' (duration: 111.937315ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:33:20.112963Z","caller":"traceutil/trace.go:171","msg":"trace[93844061] transaction","detail":"{read_only:false; response_revision:8379; number_of_response:1; }","duration":"121.897532ms","start":"2026-04-18T22:33:19.991038Z","end":"2026-04-18T22:33:20.112936Z","steps":["trace[93844061] 'process raft request' (duration: 121.733198ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:33:51.267184Z","caller":"traceutil/trace.go:171","msg":"trace[961064495] transaction","detail":"{read_only:false; response_revision:8601; number_of_response:1; }","duration":"328.291964ms","start":"2026-04-18T22:33:50.938853Z","end":"2026-04-18T22:33:51.267145Z","steps":["trace[961064495] 'process raft request' (duration: 327.786872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:33:51.267657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:33:50.938832Z","time spent":"328.470949ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:34:00.77172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.875634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:34:00.771842Z","caller":"traceutil/trace.go:171","msg":"trace[173143343] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8694; }","duration":"199.055229ms","start":"2026-04-18T22:34:00.572773Z","end":"2026-04-18T22:34:00.771829Z","steps":["trace[173143343] 'range keys from in-memory index tree' (duration: 198.778092ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:34:00.993396Z","caller":"traceutil/trace.go:171","msg":"trace[1075716968] linearizableReadLoop","detail":"{readStateIndex:8999; appliedIndex:8998; }","duration":"222.279522ms","start":"2026-04-18T22:34:00.771075Z","end":"2026-04-18T22:34:00.993355Z","steps":["trace[1075716968] 'read index received' (duration: 178.427483ms)","trace[1075716968] 'applied index is now lower than readState.Index' (duration: 43.845769ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:34:00.9936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.503287ms","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-04-18T22:34:00.993686Z","caller":"traceutil/trace.go:171","msg":"trace[790545402] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8694; }","duration":"222.635831ms","start":"2026-04-18T22:34:00.771029Z","end":"2026-04-18T22:34:00.993665Z","steps":["trace[790545402] 'agreement among raft nodes before linearized reading' (duration: 222.404825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:34:00.993823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.724172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:34:00.993895Z","caller":"traceutil/trace.go:171","msg":"trace[1205624075] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8694; }","duration":"220.845745ms","start":"2026-04-18T22:34:00.773028Z","end":"2026-04-18T22:34:00.993874Z","steps":["trace[1205624075] 'agreement among raft nodes before linearized reading' (duration: 220.614668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:34:00.993923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.397527ms","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-04-18T22:34:00.994036Z","caller":"traceutil/trace.go:171","msg":"trace[38462366] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8694; }","duration":"199.542071ms","start":"2026-04-18T22:34:00.794468Z","end":"2026-04-18T22:34:00.99401Z","steps":["trace[38462366] 'agreement among raft nodes before linearized reading' (duration: 199.239423ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:34:00.994181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.297862ms","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-04-18T22:34:00.994262Z","caller":"traceutil/trace.go:171","msg":"trace[814048678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8694; }","duration":"207.423785ms","start":"2026-04-18T22:34:00.786821Z","end":"2026-04-18T22:34:00.994245Z","steps":["trace[814048678] 'agreement among raft nodes before linearized reading' (duration: 207.065176ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:34:00.994456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.421243ms","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-04-18T22:34:00.994615Z","caller":"traceutil/trace.go:171","msg":"trace[2085637887] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8694; }","duration":"205.636359ms","start":"2026-04-18T22:34:00.788945Z","end":"2026-04-18T22:34:00.994582Z","steps":["trace[2085637887] 'agreement among raft nodes before linearized reading' (duration: 204.891ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:34:01.354774Z","caller":"traceutil/trace.go:171","msg":"trace[986971996] transaction","detail":"{read_only:false; response_revision:8701; number_of_response:1; }","duration":"182.379964ms","start":"2026-04-18T22:34:01.172344Z","end":"2026-04-18T22:34:01.354724Z","steps":["trace[986971996] 'process raft request' (duration: 182.011305ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:34:23.905062Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002439.wal"} {"level":"info","ts":"2026-04-18T22:35:01.902756Z","caller":"traceutil/trace.go:171","msg":"trace[1194385490] linearizableReadLoop","detail":"{readStateIndex:9671; appliedIndex:9670; }","duration":"180.64159ms","start":"2026-04-18T22:35:01.722078Z","end":"2026-04-18T22:35:01.90272Z","steps":["trace[1194385490] 'read index received' (duration: 180.311831ms)","trace[1194385490] 'applied index is now lower than readState.Index' (duration: 328.239µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:35:01.903219Z","caller":"traceutil/trace.go:171","msg":"trace[990533369] transaction","detail":"{read_only:false; response_revision:9349; number_of_response:1; }","duration":"214.453348ms","start":"2026-04-18T22:35:01.688751Z","end":"2026-04-18T22:35:01.903204Z","steps":["trace[990533369] 'process raft request' (duration: 213.734559ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:35:01.903658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.562544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-rgw-ceph-a-699b8bdb59-f2rnx\" ","response":"range_response_count:1 size:19350"} {"level":"info","ts":"2026-04-18T22:35:01.903701Z","caller":"traceutil/trace.go:171","msg":"trace[1232723246] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-rgw-ceph-a-699b8bdb59-f2rnx; range_end:; response_count:1; response_revision:9349; }","duration":"181.665627ms","start":"2026-04-18T22:35:01.72202Z","end":"2026-04-18T22:35:01.903686Z","steps":["trace[1232723246] 'agreement among raft nodes before linearized reading' (duration: 181.480052ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:35:01.910276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.264968ms","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-04-18T22:35:01.910413Z","caller":"traceutil/trace.go:171","msg":"trace[55823531] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:9350; }","duration":"101.480505ms","start":"2026-04-18T22:35:01.808902Z","end":"2026-04-18T22:35:01.910382Z","steps":["trace[55823531] 'agreement among raft nodes before linearized reading' (duration: 101.125465ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:35:01.910317Z","caller":"traceutil/trace.go:171","msg":"trace[208979168] transaction","detail":"{read_only:false; response_revision:9350; number_of_response:1; }","duration":"180.938908ms","start":"2026-04-18T22:35:01.729356Z","end":"2026-04-18T22:35:01.910295Z","steps":["trace[208979168] 'process raft request' (duration: 180.496457ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:35:15.182099Z","caller":"traceutil/trace.go:171","msg":"trace[1913810143] transaction","detail":"{read_only:false; response_revision:9429; number_of_response:1; }","duration":"368.659713ms","start":"2026-04-18T22:35:14.81341Z","end":"2026-04-18T22:35:15.182069Z","steps":["trace[1913810143] 'process raft request' (duration: 368.433956ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:35:15.182291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:35:14.813385Z","time spent":"368.802856ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:35:15.32075Z","caller":"traceutil/trace.go:171","msg":"trace[1706955911] transaction","detail":"{read_only:false; response_revision:9430; number_of_response:1; }","duration":"503.146684ms","start":"2026-04-18T22:35:14.817517Z","end":"2026-04-18T22:35:15.320663Z","steps":["trace[1706955911] 'process raft request' (duration: 453.593707ms)","trace[1706955911] 'compare' (duration: 49.381392ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:35:15.321005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:35:14.817491Z","time spent":"503.38014ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:35:48.290913Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"90a0cb2044183f95","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-18T22:35:48.297384Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-18T22:35:48.29752Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-18T22:38:02.644911Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8289} {"level":"info","ts":"2026-04-18T22:38:02.728573Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8289,"took":"81.155578ms","hash":604678555,"current-db-size-bytes":58441728,"current-db-size":"58 MB","current-db-size-in-use-bytes":25767936,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-18T22:38:02.728631Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":604678555,"revision":8289,"compact-revision":6095} {"level":"info","ts":"2026-04-18T22:43:02.655175Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10684} {"level":"info","ts":"2026-04-18T22:43:02.734414Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10684,"took":"76.678232ms","hash":559838129,"current-db-size-bytes":58441728,"current-db-size":"58 MB","current-db-size-in-use-bytes":20910080,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-18T22:43:02.734479Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":559838129,"revision":10684,"compact-revision":8289}