{"level":"warn","ts":"2026-04-20T01:58:13.748032Z","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-20T01:58:13.748145Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.74: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.74:2380","--initial-cluster=instance=https://199.204.45.74:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.74:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.74: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-20T01:58:13.748208Z","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-20T01:58:13.748224Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.74:2380"]}
{"level":"info","ts":"2026-04-20T01:58:13.748246Z","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-20T01:58:13.748983Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"]}
{"level":"info","ts":"2026-04-20T01:58:13.749066Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.74: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-20T01:58:13.752532Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.251171ms"}
{"level":"info","ts":"2026-04-20T01:58:13.761722Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"89ba38f964b95aa0","cluster-id":"54492f71bf65c400"}
{"level":"info","ts":"2026-04-20T01:58:13.7618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=()"}
{"level":"info","ts":"2026-04-20T01:58:13.761847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 0"}
{"level":"info","ts":"2026-04-20T01:58:13.761858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 89ba38f964b95aa0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-20T01:58:13.761865Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 1"}
{"level":"info","ts":"2026-04-20T01:58:13.761935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"}
{"level":"warn","ts":"2026-04-20T01:58:13.767646Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-20T01:58:13.768979Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-20T01:58:13.77018Z","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-20T01:58:13.772598Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"89ba38f964b95aa0","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-20T01:58:13.772842Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"89ba38f964b95aa0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-20T01:58:13.77411Z","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-20T01:58:13.775028Z","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-20T01:58:13.775047Z","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-20T01:58:13.775633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"}
{"level":"info","ts":"2026-04-20T01:58:13.775925Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","added-peer-id":"89ba38f964b95aa0","added-peer-peer-urls":["https://199.204.45.74:2380"]}
{"level":"info","ts":"2026-04-20T01:58:13.778343Z","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-20T01:58:13.778534Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.74:2380"}
{"level":"info","ts":"2026-04-20T01:58:13.778602Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.74:2380"}
{"level":"info","ts":"2026-04-20T01:58:13.778749Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"89ba38f964b95aa0","initial-advertise-peer-urls":["https://199.204.45.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-20T01:58:13.77882Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-20T01:58:14.563147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 is starting a new election at term 1"}
{"level":"info","ts":"2026-04-20T01:58:14.563225Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-20T01:58:14.563289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgPreVoteResp from 89ba38f964b95aa0 at term 1"}
{"level":"info","ts":"2026-04-20T01:58:14.563315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became candidate at term 2"}
{"level":"info","ts":"2026-04-20T01:58:14.563338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgVoteResp from 89ba38f964b95aa0 at term 2"}
{"level":"info","ts":"2026-04-20T01:58:14.563362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became leader at term 2"}
{"level":"info","ts":"2026-04-20T01:58:14.563387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 89ba38f964b95aa0 elected leader 89ba38f964b95aa0 at term 2"}
{"level":"info","ts":"2026-04-20T01:58:14.564372Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T01:58:14.565118Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"89ba38f964b95aa0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.74:2379]}","request-path":"/0/members/89ba38f964b95aa0/attributes","cluster-id":"54492f71bf65c400","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-20T01:58:14.565278Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-20T01:58:14.565311Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-20T01:58:14.567591Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.74:2379"}
{"level":"info","ts":"2026-04-20T01:58:14.568077Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-20T01:58:14.568111Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-20T01:58:14.568268Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T01:58:14.568381Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T01:58:14.56841Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T01:58:14.5684Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-20T01:58:23.276264Z","caller":"traceutil/trace.go:171","msg":"trace[374974909] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"114.517766ms","start":"2026-04-20T01:58:23.161694Z","end":"2026-04-20T01:58:23.276212Z","steps":["trace[374974909] 'process raft request'  (duration: 114.299931ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T01:58:29.095333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.539235ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6530392807185712459 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:355 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-20T01:58:29.095486Z","caller":"traceutil/trace.go:171","msg":"trace[628730369] linearizableReadLoop","detail":"{readStateIndex:375; appliedIndex:374; }","duration":"409.298437ms","start":"2026-04-20T01:58:28.686167Z","end":"2026-04-20T01:58:29.095465Z","steps":["trace[628730369] 'read index received'  (duration: 39.898579ms)","trace[628730369] 'applied index is now lower than readState.Index'  (duration: 369.398408ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T01:58:29.095546Z","caller":"traceutil/trace.go:171","msg":"trace[2061488339] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"530.756552ms","start":"2026-04-20T01:58:28.564751Z","end":"2026-04-20T01:58:29.095508Z","steps":["trace[2061488339] 'process raft request'  (duration: 161.332474ms)","trace[2061488339] 'compare'  (duration: 368.400422ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T01:58:29.095739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:58:28.564725Z","time spent":"530.923036ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:355 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-04-20T01:58:29.09579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.548884ms","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-20T01:58:29.095892Z","caller":"traceutil/trace.go:171","msg":"trace[983641179] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:363; }","duration":"409.744909ms","start":"2026-04-20T01:58:28.686118Z","end":"2026-04-20T01:58:29.095863Z","steps":["trace[983641179] 'agreement among raft nodes before linearized reading'  (duration: 409.530103ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T01:58:29.095938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:58:28.686096Z","time spent":"409.83117ms","remote":"127.0.0.1:57262","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-20T01:58:29.095995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.167713ms","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-20T01:58:29.09608Z","caller":"traceutil/trace.go:171","msg":"trace[2087868777] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:363; }","duration":"172.300556ms","start":"2026-04-20T01:58:28.923757Z","end":"2026-04-20T01:58:29.096058Z","steps":["trace[2087868777] 'agreement among raft nodes before linearized reading'  (duration: 172.124162ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T01:58:29.319786Z","caller":"traceutil/trace.go:171","msg":"trace[316088156] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"219.832914ms","start":"2026-04-20T01:58:29.099928Z","end":"2026-04-20T01:58:29.319761Z","steps":["trace[316088156] 'process raft request'  (duration: 167.593838ms)","trace[316088156] 'compare'  (duration: 52.049082ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T01:58:29.320055Z","caller":"traceutil/trace.go:171","msg":"trace[2047044567] linearizableReadLoop","detail":"{readStateIndex:377; appliedIndex:375; }","duration":"218.115812ms","start":"2026-04-20T01:58:29.101913Z","end":"2026-04-20T01:58:29.320029Z","steps":["trace[2047044567] 'read index received'  (duration: 165.560108ms)","trace[2047044567] 'applied index is now lower than readState.Index'  (duration: 52.554444ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T01:58:29.320135Z","caller":"traceutil/trace.go:171","msg":"trace[2082140880] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"219.345552ms","start":"2026-04-20T01:58:29.100756Z","end":"2026-04-20T01:58:29.320102Z","steps":["trace[2082140880] 'process raft request'  (duration: 218.924811ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T01:58:29.320182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.255625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5326"}
{"level":"info","ts":"2026-04-20T01:58:29.320221Z","caller":"traceutil/trace.go:171","msg":"trace[1160164779] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:365; }","duration":"218.334406ms","start":"2026-04-20T01:58:29.101877Z","end":"2026-04-20T01:58:29.320212Z","steps":["trace[1160164779] 'agreement among raft nodes before linearized reading'  (duration: 218.242794ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T01:58:45.095799Z","caller":"traceutil/trace.go:171","msg":"trace[1381319930] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"108.710117ms","start":"2026-04-20T01:58:44.98706Z","end":"2026-04-20T01:58:45.09577Z","steps":["trace[1381319930] 'process raft request'  (duration: 108.01701ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T01:58:45.103814Z","caller":"traceutil/trace.go:171","msg":"trace[636290598] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"113.741692ms","start":"2026-04-20T01:58:44.990053Z","end":"2026-04-20T01:58:45.103795Z","steps":["trace[636290598] 'process raft request'  (duration: 111.503346ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T01:58:45.103947Z","caller":"traceutil/trace.go:171","msg":"trace[1623706579] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"112.213624ms","start":"2026-04-20T01:58:44.991724Z","end":"2026-04-20T01:58:45.103938Z","steps":["trace[1623706579] 'process raft request'  (duration: 111.732422ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T01:58:45.104121Z","caller":"traceutil/trace.go:171","msg":"trace[1043330845] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"107.579039ms","start":"2026-04-20T01:58:44.996523Z","end":"2026-04-20T01:58:45.104102Z","steps":["trace[1043330845] 'process raft request'  (duration: 107.156469ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T01:58:45.10424Z","caller":"traceutil/trace.go:171","msg":"trace[1150798904] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"107.700492ms","start":"2026-04-20T01:58:44.996525Z","end":"2026-04-20T01:58:45.104225Z","steps":["trace[1150798904] 'process raft request'  (duration: 107.518068ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T01:58:45.104501Z","caller":"traceutil/trace.go:171","msg":"trace[1297845410] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"104.502413ms","start":"2026-04-20T01:58:44.999985Z","end":"2026-04-20T01:58:45.104487Z","steps":["trace[1297845410] 'process raft request'  (duration: 104.095854ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T01:58:45.104702Z","caller":"traceutil/trace.go:171","msg":"trace[534389361] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"103.394207ms","start":"2026-04-20T01:58:45.001301Z","end":"2026-04-20T01:58:45.104696Z","steps":["trace[534389361] 'process raft request'  (duration: 103.063647ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T01:58:45.104752Z","caller":"traceutil/trace.go:171","msg":"trace[1798253338] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"104.72424ms","start":"2026-04-20T01:58:45.000024Z","end":"2026-04-20T01:58:45.104748Z","steps":["trace[1798253338] 'process raft request'  (duration: 104.311769ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T01:58:45.841993Z","caller":"traceutil/trace.go:171","msg":"trace[241040821] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"126.463027ms","start":"2026-04-20T01:58:45.71551Z","end":"2026-04-20T01:58:45.841973Z","steps":["trace[241040821] 'process raft request'  (duration: 123.619317ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T01:58:52.009521Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530392807185712850,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-20T01:58:52.042343Z","caller":"traceutil/trace.go:171","msg":"trace[1845878575] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"533.541549ms","start":"2026-04-20T01:58:51.508778Z","end":"2026-04-20T01:58:52.042319Z","steps":["trace[1845878575] 'read index received'  (duration: 504.796469ms)","trace[1845878575] 'applied index is now lower than readState.Index'  (duration: 28.74385ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T01:58:52.042462Z","caller":"traceutil/trace.go:171","msg":"trace[1651908504] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"543.138286ms","start":"2026-04-20T01:58:51.499312Z","end":"2026-04-20T01:58:52.042451Z","steps":["trace[1651908504] 'process raft request'  (duration: 514.276503ms)","trace[1651908504] 'compare'  (duration: 28.424122ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T01:58:52.042539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:58:51.499293Z","time spent":"543.193638ms","remote":"127.0.0.1:57236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:0 > success:<request_put:<key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:2525 >> failure:<>"}
{"level":"warn","ts":"2026-04-20T01:58:52.043004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.129985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-20T01:58:52.043055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.254966ms","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-20T01:58:52.043086Z","caller":"traceutil/trace.go:171","msg":"trace[1992945248] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"345.251908ms","start":"2026-04-20T01:58:51.697813Z","end":"2026-04-20T01:58:52.043065Z","steps":["trace[1992945248] 'agreement among raft nodes before linearized reading'  (duration: 345.095004ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T01:58:52.043123Z","caller":"traceutil/trace.go:171","msg":"trace[866000853] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:580; }","duration":"534.357609ms","start":"2026-04-20T01:58:51.508744Z","end":"2026-04-20T01:58:52.043102Z","steps":["trace[866000853] 'agreement among raft nodes before linearized reading'  (duration: 534.161704ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T01:58:52.043131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:58:51.697797Z","time spent":"345.32544ms","remote":"127.0.0.1:59910","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-20T01:58:52.043157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:58:51.50873Z","time spent":"534.42225ms","remote":"127.0.0.1:57262","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-20T01:58:52.043216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.786326ms","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-20T01:58:52.043317Z","caller":"traceutil/trace.go:171","msg":"trace[1433473863] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:580; }","duration":"528.038812ms","start":"2026-04-20T01:58:51.515257Z","end":"2026-04-20T01:58:52.043296Z","steps":["trace[1433473863] 'agreement among raft nodes before linearized reading'  (duration: 527.285944ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T01:58:52.043397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:58:51.515236Z","time spent":"528.149516ms","remote":"127.0.0.1:57262","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-20T01:59:06.951657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.51646ms","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-20T01:59:06.951712Z","caller":"traceutil/trace.go:171","msg":"trace[796878606] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:734; }","duration":"319.605702ms","start":"2026-04-20T01:59:06.632092Z","end":"2026-04-20T01:59:06.951698Z","steps":["trace[796878606] 'range keys from in-memory index tree'  (duration: 319.356368ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T01:59:06.95174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T01:59:06.632074Z","time spent":"319.660602ms","remote":"127.0.0.1:57262","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-20T01:59:06.951637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.01653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-20T01:59:06.951763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.794697ms","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-20T01:59:06.951801Z","caller":"traceutil/trace.go:171","msg":"trace[1527709383] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:734; }","duration":"136.829607ms","start":"2026-04-20T01:59:06.814958Z","end":"2026-04-20T01:59:06.951788Z","steps":["trace[1527709383] 'range keys from in-memory index tree'  (duration: 136.787837ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T01:59:06.951812Z","caller":"traceutil/trace.go:171","msg":"trace[1039445364] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:734; }","duration":"254.197243ms","start":"2026-04-20T01:59:06.697581Z","end":"2026-04-20T01:59:06.951778Z","steps":["trace[1039445364] 'range keys from in-memory index tree'  (duration: 253.884197ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T01:59:08.330691Z","caller":"traceutil/trace.go:171","msg":"trace[337192667] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"100.502459ms","start":"2026-04-20T01:59:08.230152Z","end":"2026-04-20T01:59:08.330655Z","steps":["trace[337192667] 'process raft request'  (duration: 94.003441ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T01:59:08.330757Z","caller":"traceutil/trace.go:171","msg":"trace[212417727] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"100.267665ms","start":"2026-04-20T01:59:08.230446Z","end":"2026-04-20T01:59:08.330713Z","steps":["trace[212417727] 'process raft request'  (duration: 100.092332ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T01:59:43.698209Z","caller":"traceutil/trace.go:171","msg":"trace[1906009395] linearizableReadLoop","detail":"{readStateIndex:1206; appliedIndex:1205; }","duration":"190.421241ms","start":"2026-04-20T01:59:43.507768Z","end":"2026-04-20T01:59:43.698189Z","steps":["trace[1906009395] 'read index received'  (duration: 186.671086ms)","trace[1906009395] 'applied index is now lower than readState.Index'  (duration: 3.748655ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T01:59:43.698351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.551603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T01:59:43.698401Z","caller":"traceutil/trace.go:171","msg":"trace[1432519213] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1170; }","duration":"190.627304ms","start":"2026-04-20T01:59:43.507761Z","end":"2026-04-20T01:59:43.698389Z","steps":["trace[1432519213] 'agreement among raft nodes before linearized reading'  (duration: 190.526452ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T01:59:43.69841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.196556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-04-20T01:59:43.698442Z","caller":"traceutil/trace.go:171","msg":"trace[1739177981] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1170; }","duration":"137.265176ms","start":"2026-04-20T01:59:43.561168Z","end":"2026-04-20T01:59:43.698434Z","steps":["trace[1739177981] 'agreement among raft nodes before linearized reading'  (duration: 137.147344ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T01:59:43.698685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.080513ms","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-20T01:59:43.698709Z","caller":"traceutil/trace.go:171","msg":"trace[403632995] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1170; }","duration":"137.124333ms","start":"2026-04-20T01:59:43.561579Z","end":"2026-04-20T01:59:43.698704Z","steps":["trace[403632995] 'agreement among raft nodes before linearized reading'  (duration: 137.065732ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:00:32.857432Z","caller":"traceutil/trace.go:171","msg":"trace[124324028] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"224.959851ms","start":"2026-04-20T02:00:32.632455Z","end":"2026-04-20T02:00:32.857414Z","steps":["trace[124324028] 'process raft request'  (duration: 224.784117ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:00:32.857527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.894935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:00:32.85741Z","caller":"traceutil/trace.go:171","msg":"trace[895117144] linearizableReadLoop","detail":"{readStateIndex:1923; appliedIndex:1922; }","duration":"154.770032ms","start":"2026-04-20T02:00:32.702617Z","end":"2026-04-20T02:00:32.857387Z","steps":["trace[895117144] 'read index received'  (duration: 154.640549ms)","trace[895117144] 'applied index is now lower than readState.Index'  (duration: 128.363µs)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:00:32.857603Z","caller":"traceutil/trace.go:171","msg":"trace[1407223552] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1851; }","duration":"154.991307ms","start":"2026-04-20T02:00:32.702572Z","end":"2026-04-20T02:00:32.857563Z","steps":["trace[1407223552] 'agreement among raft nodes before linearized reading'  (duration: 154.898465ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:00:32.8652Z","caller":"traceutil/trace.go:171","msg":"trace[307637570] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"160.593299ms","start":"2026-04-20T02:00:32.704584Z","end":"2026-04-20T02:00:32.865178Z","steps":["trace[307637570] 'process raft request'  (duration: 160.246111ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:00:32.865738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.709853ms","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-20T02:00:32.865825Z","caller":"traceutil/trace.go:171","msg":"trace[1107294772] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1853; }","duration":"144.842765ms","start":"2026-04-20T02:00:32.720966Z","end":"2026-04-20T02:00:32.865808Z","steps":["trace[1107294772] 'agreement among raft nodes before linearized reading'  (duration: 144.631141ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:00:32.866126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.272049ms","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-20T02:00:32.866211Z","caller":"traceutil/trace.go:171","msg":"trace[219160102] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1853; }","duration":"153.397811ms","start":"2026-04-20T02:00:32.712796Z","end":"2026-04-20T02:00:32.866194Z","steps":["trace[219160102] 'agreement among raft nodes before linearized reading'  (duration: 153.187447ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:00:45.584144Z","caller":"traceutil/trace.go:171","msg":"trace[537626071] linearizableReadLoop","detail":"{readStateIndex:2032; appliedIndex:2031; }","duration":"324.551981ms","start":"2026-04-20T02:00:45.25957Z","end":"2026-04-20T02:00:45.584122Z","steps":["trace[537626071] 'read index received'  (duration: 324.352067ms)","trace[537626071] 'applied index is now lower than readState.Index'  (duration: 199.074µs)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:00:45.584261Z","caller":"traceutil/trace.go:171","msg":"trace[692817911] transaction","detail":"{read_only:false; response_revision:1956; number_of_response:1; }","duration":"390.956741ms","start":"2026-04-20T02:00:45.193292Z","end":"2026-04-20T02:00:45.584249Z","steps":["trace[692817911] 'process raft request'  (duration: 390.676115ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:00:45.584362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:45.193274Z","time spent":"391.013392ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:1947 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-20T02:00:45.584555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.99301ms","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-20T02:00:45.584586Z","caller":"traceutil/trace.go:171","msg":"trace[1808876603] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1956; }","duration":"325.057602ms","start":"2026-04-20T02:00:45.259516Z","end":"2026-04-20T02:00:45.584574Z","steps":["trace[1808876603] 'agreement among raft nodes before linearized reading'  (duration: 324.95242ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:00:45.584613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:00:45.259497Z","time spent":"325.110194ms","remote":"127.0.0.1:58078","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-20T02:00:45.584802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.612208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:00:45.584878Z","caller":"traceutil/trace.go:171","msg":"trace[2054043752] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1956; }","duration":"238.732351ms","start":"2026-04-20T02:00:45.346126Z","end":"2026-04-20T02:00:45.584858Z","steps":["trace[2054043752] 'agreement among raft nodes before linearized reading'  (duration: 238.616389ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:00:45.58504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.75993ms","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-20T02:00:45.585073Z","caller":"traceutil/trace.go:171","msg":"trace[1826355162] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1956; }","duration":"129.827692ms","start":"2026-04-20T02:00:45.455236Z","end":"2026-04-20T02:00:45.585064Z","steps":["trace[1826355162] 'agreement among raft nodes before linearized reading'  (duration: 129.74252ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:01:06.836546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.907778ms","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-20T02:01:06.836666Z","caller":"traceutil/trace.go:171","msg":"trace[1031741469] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2087; }","duration":"110.108783ms","start":"2026-04-20T02:01:06.72653Z","end":"2026-04-20T02:01:06.836639Z","steps":["trace[1031741469] 'range keys from in-memory index tree'  (duration: 109.684184ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:01:07.278147Z","caller":"traceutil/trace.go:171","msg":"trace[1099600000] transaction","detail":"{read_only:false; response_revision:2091; number_of_response:1; }","duration":"146.403744ms","start":"2026-04-20T02:01:07.131709Z","end":"2026-04-20T02:01:07.278113Z","steps":["trace[1099600000] 'process raft request'  (duration: 132.770246ms)","trace[1099600000] 'compare'  (duration: 13.503145ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:01:08.060487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.541767ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6530392807185715925 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2084 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-20T02:01:08.060664Z","caller":"traceutil/trace.go:171","msg":"trace[1566685907] transaction","detail":"{read_only:false; response_revision:2093; number_of_response:1; }","duration":"307.0415ms","start":"2026-04-20T02:01:07.753596Z","end":"2026-04-20T02:01:08.060638Z","steps":["trace[1566685907] 'process raft request'  (duration: 149.268408ms)","trace[1566685907] 'compare'  (duration: 157.376473ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:01:08.060814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:01:07.753581Z","time spent":"307.160062ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2084 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-04-20T02:01:08.060787Z","caller":"traceutil/trace.go:171","msg":"trace[1058081143] linearizableReadLoop","detail":"{readStateIndex:2173; appliedIndex:2172; }","duration":"217.199493ms","start":"2026-04-20T02:01:07.843574Z","end":"2026-04-20T02:01:08.060774Z","steps":["trace[1058081143] 'read index received'  (duration: 59.37406ms)","trace[1058081143] 'applied index is now lower than readState.Index'  (duration: 157.824073ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:01:08.060981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.407057ms","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-20T02:01:08.061028Z","caller":"traceutil/trace.go:171","msg":"trace[768338690] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2093; }","duration":"217.473508ms","start":"2026-04-20T02:01:07.843538Z","end":"2026-04-20T02:01:08.061012Z","steps":["trace[768338690] 'agreement among raft nodes before linearized reading'  (duration: 217.305694ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:01:08.22617Z","caller":"traceutil/trace.go:171","msg":"trace[1762645327] transaction","detail":"{read_only:false; response_revision:2094; number_of_response:1; }","duration":"132.920141ms","start":"2026-04-20T02:01:08.093221Z","end":"2026-04-20T02:01:08.226141Z","steps":["trace[1762645327] 'process raft request'  (duration: 111.815365ms)","trace[1762645327] 'compare'  (duration: 20.985303ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:01:08.31954Z","caller":"traceutil/trace.go:171","msg":"trace[1142059584] linearizableReadLoop","detail":"{readStateIndex:2175; appliedIndex:2174; }","duration":"112.4793ms","start":"2026-04-20T02:01:08.207038Z","end":"2026-04-20T02:01:08.319517Z","steps":["trace[1142059584] 'read index received'  (duration: 112.301986ms)","trace[1142059584] 'applied index is now lower than readState.Index'  (duration: 176.414µs)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:01:08.31964Z","caller":"traceutil/trace.go:171","msg":"trace[714645987] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"226.118587ms","start":"2026-04-20T02:01:08.093492Z","end":"2026-04-20T02:01:08.31961Z","steps":["trace[714645987] 'process raft request'  (duration: 225.924753ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:01:08.319748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.675145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.74\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-04-20T02:01:08.319804Z","caller":"traceutil/trace.go:171","msg":"trace[1038057888] range","detail":"{range_begin:/registry/masterleases/199.204.45.74; range_end:; response_count:1; response_revision:2095; }","duration":"112.810038ms","start":"2026-04-20T02:01:08.206984Z","end":"2026-04-20T02:01:08.319794Z","steps":["trace[1038057888] 'agreement among raft nodes before linearized reading'  (duration: 112.621804ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:01:08.542287Z","caller":"traceutil/trace.go:171","msg":"trace[420390475] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"183.831691ms","start":"2026-04-20T02:01:08.358427Z","end":"2026-04-20T02:01:08.542258Z","steps":["trace[420390475] 'process raft request'  (duration: 167.115124ms)","trace[420390475] 'compare'  (duration: 16.593275ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:01:16.067804Z","caller":"traceutil/trace.go:171","msg":"trace[1448509526] linearizableReadLoop","detail":"{readStateIndex:2217; appliedIndex:2216; }","duration":"423.949682ms","start":"2026-04-20T02:01:15.643828Z","end":"2026-04-20T02:01:16.067778Z","steps":["trace[1448509526] 'read index received'  (duration: 423.766548ms)","trace[1448509526] 'applied index is now lower than readState.Index'  (duration: 182.124µs)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:01:16.067912Z","caller":"traceutil/trace.go:171","msg":"trace[1794733590] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"755.159209ms","start":"2026-04-20T02:01:15.312722Z","end":"2026-04-20T02:01:16.067881Z","steps":["trace[1794733590] 'process raft request'  (duration: 754.889533ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:01:16.068059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.209518ms","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":"warn","ts":"2026-04-20T02:01:16.068086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:01:15.312705Z","time spent":"755.280821ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2124 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-04-20T02:01:16.068136Z","caller":"traceutil/trace.go:171","msg":"trace[188416313] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:2135; }","duration":"424.337831ms","start":"2026-04-20T02:01:15.643781Z","end":"2026-04-20T02:01:16.068119Z","steps":["trace[188416313] 'agreement among raft nodes before linearized reading'  (duration: 424.108336ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:01:16.068195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:01:15.643762Z","time spent":"424.425322ms","remote":"127.0.0.1:50592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":17,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "}
{"level":"info","ts":"2026-04-20T02:01:16.492102Z","caller":"traceutil/trace.go:171","msg":"trace[378831843] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"714.685446ms","start":"2026-04-20T02:01:15.777392Z","end":"2026-04-20T02:01:16.492077Z","steps":["trace[378831843] 'process raft request'  (duration: 660.170308ms)","trace[378831843] 'compare'  (duration: 54.358244ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:01:16.492193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.526688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:01:16.492228Z","caller":"traceutil/trace.go:171","msg":"trace[974136703] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2136; }","duration":"794.603179ms","start":"2026-04-20T02:01:15.697616Z","end":"2026-04-20T02:01:16.492219Z","steps":["trace[974136703] 'agreement among raft nodes before linearized reading'  (duration: 794.528637ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:01:16.492256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:01:15.697598Z","time spent":"794.651681ms","remote":"127.0.0.1:59910","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-20T02:01:16.492253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:01:15.777369Z","time spent":"714.799768ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2126 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-20T02:01:16.492238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.103903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-20T02:01:16.49232Z","caller":"traceutil/trace.go:171","msg":"trace[1556010391] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:2136; }","duration":"636.233966ms","start":"2026-04-20T02:01:15.856063Z","end":"2026-04-20T02:01:16.492297Z","steps":["trace[1556010391] 'agreement among raft nodes before linearized reading'  (duration: 636.084142ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:01:16.492289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.935585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"}
{"level":"warn","ts":"2026-04-20T02:01:16.492364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:01:15.856038Z","time spent":"636.315497ms","remote":"127.0.0.1:57498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":2,"response size":30,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "}
{"level":"info","ts":"2026-04-20T02:01:16.492103Z","caller":"traceutil/trace.go:171","msg":"trace[1977874642] linearizableReadLoop","detail":"{readStateIndex:2218; appliedIndex:2217; }","duration":"424.117481ms","start":"2026-04-20T02:01:16.067951Z","end":"2026-04-20T02:01:16.492068Z","steps":["trace[1977874642] 'read index received'  (duration: 369.48101ms)","trace[1977874642] 'applied index is now lower than readState.Index'  (duration: 54.63504ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:01:16.492397Z","caller":"traceutil/trace.go:171","msg":"trace[118784372] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2136; }","duration":"464.123799ms","start":"2026-04-20T02:01:16.028256Z","end":"2026-04-20T02:01:16.49238Z","steps":["trace[118784372] 'agreement among raft nodes before linearized reading'  (duration: 463.926275ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:01:16.492472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:01:16.028245Z","time spent":"464.215591ms","remote":"127.0.0.1:59962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":141,"request content":"key:\"/registry/ranges/servicenodeports\" "}
{"level":"warn","ts":"2026-04-20T02:01:16.492564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.152399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-04-20T02:01:16.492596Z","caller":"traceutil/trace.go:171","msg":"trace[592065035] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2136; }","duration":"405.218801ms","start":"2026-04-20T02:01:16.087367Z","end":"2026-04-20T02:01:16.492586Z","steps":["trace[592065035] 'agreement among raft nodes before linearized reading'  (duration: 405.120529ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:01:16.492653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:01:16.087312Z","time spent":"405.334213ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-20T02:01:16.492505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.345093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12385"}
{"level":"warn","ts":"2026-04-20T02:01:16.49271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.539978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-04-20T02:01:16.492721Z","caller":"traceutil/trace.go:171","msg":"trace[1847790114] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2136; }","duration":"649.591909ms","start":"2026-04-20T02:01:15.843117Z","end":"2026-04-20T02:01:16.492709Z","steps":["trace[1847790114] 'agreement among raft nodes before linearized reading'  (duration: 649.288282ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:01:16.492743Z","caller":"traceutil/trace.go:171","msg":"trace[1906972117] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2136; }","duration":"146.611029ms","start":"2026-04-20T02:01:16.346122Z","end":"2026-04-20T02:01:16.492733Z","steps":["trace[1906972117] 'agreement among raft nodes before linearized reading'  (duration: 146.525908ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:01:16.492775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:01:15.843092Z","time spent":"649.67035ms","remote":"127.0.0.1:57178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12408,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-04-20T02:01:16.49266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.863302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:116482"}
{"level":"warn","ts":"2026-04-20T02:01:16.492841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.252756ms","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-20T02:01:16.492879Z","caller":"traceutil/trace.go:171","msg":"trace[534599122] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2136; }","duration":"384.326877ms","start":"2026-04-20T02:01:16.10854Z","end":"2026-04-20T02:01:16.492867Z","steps":["trace[534599122] 'agreement among raft nodes before linearized reading'  (duration: 384.230975ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:01:16.49288Z","caller":"traceutil/trace.go:171","msg":"trace[216000071] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2136; }","duration":"475.119498ms","start":"2026-04-20T02:01:16.01774Z","end":"2026-04-20T02:01:16.49286Z","steps":["trace[216000071] 'agreement among raft nodes before linearized reading'  (duration: 474.373372ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:01:16.492894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.616829ms","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-20T02:01:16.493902Z","caller":"traceutil/trace.go:171","msg":"trace[300162710] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2136; }","duration":"239.655482ms","start":"2026-04-20T02:01:16.254232Z","end":"2026-04-20T02:01:16.493887Z","steps":["trace[300162710] 'agreement among raft nodes before linearized reading'  (duration: 238.602948ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:01:16.492907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:01:16.108519Z","time spent":"384.381568ms","remote":"127.0.0.1:58078","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-20T02:01:16.492927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:01:16.017725Z","time spent":"475.186889ms","remote":"127.0.0.1:59956","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":116505,"request content":"key:\"/registry/ranges/serviceips\" "}
{"level":"warn","ts":"2026-04-20T02:02:05.173991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.34678ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6530392807185716722 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/deployments/openstack/memcached-memcached\" mod_revision:2430 > success:<request_put:<key:\"/registry/deployments/openstack/memcached-memcached\" value_size:7144 >> failure:<request_range:<key:\"/registry/deployments/openstack/memcached-memcached\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-20T02:02:05.174401Z","caller":"traceutil/trace.go:171","msg":"trace[1067447938] linearizableReadLoop","detail":"{readStateIndex:2527; appliedIndex:2526; }","duration":"533.019615ms","start":"2026-04-20T02:02:04.641368Z","end":"2026-04-20T02:02:05.174388Z","steps":["trace[1067447938] 'read index received'  (duration: 335.175814ms)","trace[1067447938] 'applied index is now lower than readState.Index'  (duration: 197.842541ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:02:05.17448Z","caller":"traceutil/trace.go:171","msg":"trace[1312825344] transaction","detail":"{read_only:false; response_revision:2433; number_of_response:1; }","duration":"561.646978ms","start":"2026-04-20T02:02:04.612799Z","end":"2026-04-20T02:02:05.174446Z","steps":["trace[1312825344] 'process raft request'  (duration: 363.770417ms)","trace[1312825344] 'compare'  (duration: 197.137674ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:02:05.17464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:04.612787Z","time spent":"561.784102ms","remote":"127.0.0.1:57444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7203,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/deployments/openstack/memcached-memcached\" mod_revision:2430 > success:<request_put:<key:\"/registry/deployments/openstack/memcached-memcached\" value_size:7144 >> failure:<request_range:<key:\"/registry/deployments/openstack/memcached-memcached\" > >"}
{"level":"warn","ts":"2026-04-20T02:02:05.174867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.503185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:6 size:236304"}
{"level":"info","ts":"2026-04-20T02:02:05.174896Z","caller":"traceutil/trace.go:171","msg":"trace[1085826248] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:6; response_revision:2433; }","duration":"533.572627ms","start":"2026-04-20T02:02:04.641315Z","end":"2026-04-20T02:02:05.174888Z","steps":["trace[1085826248] 'agreement among raft nodes before linearized reading'  (duration: 533.221199ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:02:05.174957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:04.641295Z","time spent":"533.653469ms","remote":"127.0.0.1:59988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":6,"response size":236327,"request content":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" "}
{"level":"info","ts":"2026-04-20T02:02:05.175418Z","caller":"traceutil/trace.go:171","msg":"trace[95417892] transaction","detail":"{read_only:false; response_revision:2435; number_of_response:1; }","duration":"350.803528ms","start":"2026-04-20T02:02:04.824597Z","end":"2026-04-20T02:02:05.175401Z","steps":["trace[95417892] 'process raft request'  (duration: 350.748556ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:02:05.175534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:04.824519Z","time spent":"350.957932ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2407 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-20T02:02:05.175875Z","caller":"traceutil/trace.go:171","msg":"trace[453147096] transaction","detail":"{read_only:false; response_revision:2434; number_of_response:1; }","duration":"526.622566ms","start":"2026-04-20T02:02:04.649237Z","end":"2026-04-20T02:02:05.17586Z","steps":["trace[453147096] 'process raft request'  (duration: 525.984931ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:02:05.175962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:04.649206Z","time spent":"526.713169ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2403 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-20T02:02:05.177838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.402668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:02:05.177974Z","caller":"traceutil/trace.go:171","msg":"trace[1017115938] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2436; }","duration":"481.599312ms","start":"2026-04-20T02:02:04.696337Z","end":"2026-04-20T02:02:05.177936Z","steps":["trace[1017115938] 'agreement among raft nodes before linearized reading'  (duration: 481.395617ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:02:05.178057Z","caller":"traceutil/trace.go:171","msg":"trace[298859107] transaction","detail":"{read_only:false; response_revision:2436; number_of_response:1; }","duration":"121.511389ms","start":"2026-04-20T02:02:05.056527Z","end":"2026-04-20T02:02:05.178038Z","steps":["trace[298859107] 'process raft request'  (duration: 121.11502ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:02:05.178225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.435247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-04-20T02:02:05.178336Z","caller":"traceutil/trace.go:171","msg":"trace[1765985268] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2436; }","duration":"465.56199ms","start":"2026-04-20T02:02:04.712741Z","end":"2026-04-20T02:02:05.178303Z","steps":["trace[1765985268] 'agreement among raft nodes before linearized reading'  (duration: 465.349145ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:02:05.178387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:04.712717Z","time spent":"465.661103ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-04-20T02:02:05.178073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:04.696321Z","time spent":"481.743026ms","remote":"127.0.0.1:59912","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-20T02:02:05.178331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.08104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/memcached-memcached\" ","response":"range_response_count:1 size:543"}
{"level":"info","ts":"2026-04-20T02:02:05.178891Z","caller":"traceutil/trace.go:171","msg":"trace[1537926828] range","detail":"{range_begin:/registry/serviceaccounts/openstack/memcached-memcached; range_end:; response_count:1; response_revision:2436; }","duration":"287.661634ms","start":"2026-04-20T02:02:04.891199Z","end":"2026-04-20T02:02:05.178861Z","steps":["trace[1537926828] 'agreement among raft nodes before linearized reading'  (duration: 287.039529ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:02:05.177873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.641653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-20T02:02:05.179141Z","caller":"traceutil/trace.go:171","msg":"trace[1739116518] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2436; }","duration":"410.940894ms","start":"2026-04-20T02:02:04.76817Z","end":"2026-04-20T02:02:05.179111Z","steps":["trace[1739116518] 'agreement among raft nodes before linearized reading'  (duration: 409.643773ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:02:05.179196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:04.76815Z","time spent":"411.034035ms","remote":"127.0.0.1:58032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"warn","ts":"2026-04-20T02:02:05.179687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.87059ms","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-20T02:02:05.179727Z","caller":"traceutil/trace.go:171","msg":"trace[389467810] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2436; }","duration":"472.930252ms","start":"2026-04-20T02:02:04.706787Z","end":"2026-04-20T02:02:05.179717Z","steps":["trace[389467810] 'agreement among raft nodes before linearized reading'  (duration: 471.685693ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:02:05.179752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:04.706778Z","time spent":"472.967412ms","remote":"127.0.0.1:57262","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-20T02:02:05.17991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.347772ms","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-20T02:02:05.179941Z","caller":"traceutil/trace.go:171","msg":"trace[571642219] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2436; }","duration":"470.412763ms","start":"2026-04-20T02:02:04.709519Z","end":"2026-04-20T02:02:05.179932Z","steps":["trace[571642219] 'agreement among raft nodes before linearized reading'  (duration: 470.335552ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:02:05.179966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:04.709499Z","time spent":"470.461234ms","remote":"127.0.0.1:57262","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":"info","ts":"2026-04-20T02:02:05.817814Z","caller":"traceutil/trace.go:171","msg":"trace[1748778741] transaction","detail":"{read_only:false; response_revision:2444; number_of_response:1; }","duration":"202.422477ms","start":"2026-04-20T02:02:05.615346Z","end":"2026-04-20T02:02:05.817769Z","steps":["trace[1748778741] 'process raft request'  (duration: 104.579437ms)","trace[1748778741] 'compare'  (duration: 97.702757ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:02:14.021105Z","caller":"traceutil/trace.go:171","msg":"trace[427724637] transaction","detail":"{read_only:false; response_revision:2550; number_of_response:1; }","duration":"101.804827ms","start":"2026-04-20T02:02:13.919278Z","end":"2026-04-20T02:02:14.021082Z","steps":["trace[427724637] 'process raft request'  (duration: 101.654684ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:02:14.419349Z","caller":"traceutil/trace.go:171","msg":"trace[139985188] transaction","detail":"{read_only:false; response_revision:2551; number_of_response:1; }","duration":"389.227443ms","start":"2026-04-20T02:02:14.03009Z","end":"2026-04-20T02:02:14.419318Z","steps":["trace[139985188] 'process raft request'  (duration: 361.046777ms)","trace[139985188] 'compare'  (duration: 27.03715ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:02:14.419709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:14.030066Z","time spent":"389.571891ms","remote":"127.0.0.1:50568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3071,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/cilium.io/ciliumendpoints/auth-system/keycloak-0\" mod_revision:0 > success:<request_put:<key:\"/registry/cilium.io/ciliumendpoints/auth-system/keycloak-0\" value_size:3005 >> failure:<>"}
{"level":"warn","ts":"2026-04-20T02:02:15.82896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.812242ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6530392807185716964 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:2436 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-20T02:02:15.829264Z","caller":"traceutil/trace.go:171","msg":"trace[545308660] linearizableReadLoop","detail":"{readStateIndex:2658; appliedIndex:2657; }","duration":"309.108442ms","start":"2026-04-20T02:02:15.519913Z","end":"2026-04-20T02:02:15.829021Z","steps":["trace[545308660] 'read index received'  (duration: 22.085244ms)","trace[545308660] 'applied index is now lower than readState.Index'  (duration: 287.022208ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:02:15.829328Z","caller":"traceutil/trace.go:171","msg":"trace[781815846] transaction","detail":"{read_only:false; response_revision:2562; number_of_response:1; }","duration":"335.681039ms","start":"2026-04-20T02:02:15.493638Z","end":"2026-04-20T02:02:15.82932Z","steps":["trace[781815846] 'process raft request'  (duration: 48.436776ms)","trace[781815846] 'compare'  (duration: 286.656299ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:02:15.829377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:15.493609Z","time spent":"335.738291ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:2436 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-04-20T02:02:15.829606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.933449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-20T02:02:15.829601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.222588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-20T02:02:15.829673Z","caller":"traceutil/trace.go:171","msg":"trace[740808689] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2562; }","duration":"132.035481ms","start":"2026-04-20T02:02:15.697621Z","end":"2026-04-20T02:02:15.829656Z","steps":["trace[740808689] 'agreement among raft nodes before linearized reading'  (duration: 131.906248ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:02:15.829735Z","caller":"traceutil/trace.go:171","msg":"trace[433351944] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:2562; }","duration":"160.407073ms","start":"2026-04-20T02:02:15.66931Z","end":"2026-04-20T02:02:15.829717Z","steps":["trace[433351944] 'agreement among raft nodes before linearized reading'  (duration: 160.215888ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:02:15.82963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.712686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"info","ts":"2026-04-20T02:02:15.829875Z","caller":"traceutil/trace.go:171","msg":"trace[1581249704] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2562; }","duration":"309.989052ms","start":"2026-04-20T02:02:15.519877Z","end":"2026-04-20T02:02:15.829867Z","steps":["trace[1581249704] 'agreement among raft nodes before linearized reading'  (duration: 309.646164ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:02:15.829897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:15.519861Z","time spent":"310.028733ms","remote":"127.0.0.1:57186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "}
{"level":"info","ts":"2026-04-20T02:02:39.53459Z","caller":"traceutil/trace.go:171","msg":"trace[1697013038] transaction","detail":"{read_only:false; response_revision:2691; number_of_response:1; }","duration":"147.11808ms","start":"2026-04-20T02:02:39.387446Z","end":"2026-04-20T02:02:39.534565Z","steps":["trace[1697013038] 'process raft request'  (duration: 146.950465ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:02:39.535188Z","caller":"traceutil/trace.go:171","msg":"trace[1900333029] transaction","detail":"{read_only:false; response_revision:2692; number_of_response:1; }","duration":"147.088439ms","start":"2026-04-20T02:02:39.388083Z","end":"2026-04-20T02:02:39.535171Z","steps":["trace[1900333029] 'process raft request'  (duration: 146.881334ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:02:39.535221Z","caller":"traceutil/trace.go:171","msg":"trace[1774334349] transaction","detail":"{read_only:false; response_revision:2694; number_of_response:1; }","duration":"139.174214ms","start":"2026-04-20T02:02:39.39602Z","end":"2026-04-20T02:02:39.535194Z","steps":["trace[1774334349] 'process raft request'  (duration: 139.092932ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:02:39.535318Z","caller":"traceutil/trace.go:171","msg":"trace[1299491512] transaction","detail":"{read_only:false; response_revision:2693; number_of_response:1; }","duration":"147.13398ms","start":"2026-04-20T02:02:39.388174Z","end":"2026-04-20T02:02:39.535308Z","steps":["trace[1299491512] 'process raft request'  (duration: 146.905395ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:02:39.53535Z","caller":"traceutil/trace.go:171","msg":"trace[487677107] transaction","detail":"{read_only:false; response_revision:2695; number_of_response:1; }","duration":"138.159111ms","start":"2026-04-20T02:02:39.397169Z","end":"2026-04-20T02:02:39.535328Z","steps":["trace[487677107] 'process raft request'  (duration: 137.971656ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:02:50.99531Z","caller":"traceutil/trace.go:171","msg":"trace[319388470] transaction","detail":"{read_only:false; response_revision:2751; number_of_response:1; }","duration":"401.014052ms","start":"2026-04-20T02:02:50.59427Z","end":"2026-04-20T02:02:50.995284Z","steps":["trace[319388470] 'process raft request'  (duration: 400.863608ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:02:50.995528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:02:50.594254Z","time spent":"401.161975ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2740 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-04-20T02:05:18.721525Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530392807185719812,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-20T02:05:19.222252Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530392807185719812,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-20T02:05:19.402647Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.256098408s","expected-duration":"1s"}
{"level":"info","ts":"2026-04-20T02:05:19.403346Z","caller":"traceutil/trace.go:171","msg":"trace[1380596188] transaction","detail":"{read_only:false; response_revision:3619; number_of_response:1; }","duration":"1.256895946s","start":"2026-04-20T02:05:18.14641Z","end":"2026-04-20T02:05:19.403306Z","steps":["trace[1380596188] 'process raft request'  (duration: 1.256598379s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:05:19.403761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.146385Z","time spent":"1.257143702s","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:3610 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-04-20T02:05:19.427672Z","caller":"traceutil/trace.go:171","msg":"trace[11601612] linearizableReadLoop","detail":"{readStateIndex:3758; appliedIndex:3756; }","duration":"1.206646602s","start":"2026-04-20T02:05:18.220991Z","end":"2026-04-20T02:05:19.427638Z","steps":["trace[11601612] 'read index received'  (duration: 1.182133253s)","trace[11601612] 'applied index is now lower than readState.Index'  (duration: 24.509659ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:05:19.427735Z","caller":"traceutil/trace.go:171","msg":"trace[1607228827] transaction","detail":"{read_only:false; response_revision:3620; number_of_response:1; }","duration":"1.280062495s","start":"2026-04-20T02:05:18.147656Z","end":"2026-04-20T02:05:19.427719Z","steps":["trace[1607228827] 'process raft request'  (duration: 1.277043338s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:05:19.427808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.147624Z","time spent":"1.280146697s","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:3611 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-20T02:05:19.428054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.207030791s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.74\" ","response":"range_response_count:1 size:133"}
{"level":"warn","ts":"2026-04-20T02:05:19.428136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"998.946167ms","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-20T02:05:19.428113Z","caller":"traceutil/trace.go:171","msg":"trace[510627866] range","detail":"{range_begin:/registry/masterleases/199.204.45.74; range_end:; response_count:1; response_revision:3620; }","duration":"1.207140804s","start":"2026-04-20T02:05:18.220956Z","end":"2026-04-20T02:05:19.428097Z","steps":["trace[510627866] 'agreement among raft nodes before linearized reading'  (duration: 1.206870648s)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:05:19.428174Z","caller":"traceutil/trace.go:171","msg":"trace[267078781] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3620; }","duration":"999.004578ms","start":"2026-04-20T02:05:18.42916Z","end":"2026-04-20T02:05:19.428165Z","steps":["trace[267078781] 'agreement among raft nodes before linearized reading'  (duration: 998.846005ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:05:19.428199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.429151Z","time spent":"999.043839ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-20T02:05:19.428197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.220943Z","time spent":"1.207239436s","remote":"127.0.0.1:59934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.74\" "}
{"level":"warn","ts":"2026-04-20T02:05:19.428318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"999.059529ms","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-20T02:05:19.428342Z","caller":"traceutil/trace.go:171","msg":"trace[1744312727] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3620; }","duration":"999.113531ms","start":"2026-04-20T02:05:18.429223Z","end":"2026-04-20T02:05:19.428337Z","steps":["trace[1744312727] 'agreement among raft nodes before linearized reading'  (duration: 999.042539ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:05:19.428361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.429208Z","time spent":"999.148102ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-20T02:05:19.428412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.01250091s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"warn","ts":"2026-04-20T02:05:19.42858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.322754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-20T02:05:19.428439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.1967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:05:19.428708Z","caller":"traceutil/trace.go:171","msg":"trace[1076893141] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:3620; }","duration":"546.511318ms","start":"2026-04-20T02:05:18.882188Z","end":"2026-04-20T02:05:19.428699Z","steps":["trace[1076893141] 'agreement among raft nodes before linearized reading'  (duration: 546.223061ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:05:19.428732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.882163Z","time spent":"546.561428ms","remote":"127.0.0.1:57406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "}
{"level":"warn","ts":"2026-04-20T02:05:19.428391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.102255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-04-20T02:05:19.42865Z","caller":"traceutil/trace.go:171","msg":"trace[1401136812] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3620; }","duration":"732.421436ms","start":"2026-04-20T02:05:18.69621Z","end":"2026-04-20T02:05:19.428631Z","steps":["trace[1401136812] 'agreement among raft nodes before linearized reading'  (duration: 732.228942ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:05:19.428509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.957798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-cookie-secret\" ","response":"range_response_count:1 size:1229"}
{"level":"info","ts":"2026-04-20T02:05:19.428844Z","caller":"traceutil/trace.go:171","msg":"trace[960246823] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3620; }","duration":"170.573646ms","start":"2026-04-20T02:05:19.258203Z","end":"2026-04-20T02:05:19.428777Z","steps":["trace[960246823] 'agreement among raft nodes before linearized reading'  (duration: 169.841589ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:05:19.428874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.696189Z","time spent":"732.60627ms","remote":"127.0.0.1:59912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-20T02:05:19.428619Z","caller":"traceutil/trace.go:171","msg":"trace[110082149] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3620; }","duration":"1.012759667s","start":"2026-04-20T02:05:18.415792Z","end":"2026-04-20T02:05:19.428552Z","steps":["trace[110082149] 'agreement among raft nodes before linearized reading'  (duration: 1.012193773s)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:05:19.428939Z","caller":"traceutil/trace.go:171","msg":"trace[221350693] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-cookie-secret; range_end:; response_count:1; response_revision:3620; }","duration":"750.380128ms","start":"2026-04-20T02:05:18.678507Z","end":"2026-04-20T02:05:19.428887Z","steps":["trace[221350693] 'agreement among raft nodes before linearized reading'  (duration: 749.483277ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:05:19.430176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.415774Z","time spent":"1.014351752s","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-20T02:05:19.430246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.678488Z","time spent":"751.737667ms","remote":"127.0.0.1:60878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":1252,"request content":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-cookie-secret\" "}
{"level":"warn","ts":"2026-04-20T02:05:19.42906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.001883824s","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-20T02:05:19.430389Z","caller":"traceutil/trace.go:171","msg":"trace[1481256434] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3620; }","duration":"1.003249923s","start":"2026-04-20T02:05:18.427111Z","end":"2026-04-20T02:05:19.430361Z","steps":["trace[1481256434] 'agreement among raft nodes before linearized reading'  (duration: 1.001018533s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:05:19.430436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:05:18.427098Z","time spent":"1.003327775s","remote":"127.0.0.1:57262","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":"info","ts":"2026-04-20T02:05:37.626125Z","caller":"traceutil/trace.go:171","msg":"trace[184573390] transaction","detail":"{read_only:false; response_revision:3751; number_of_response:1; }","duration":"133.226788ms","start":"2026-04-20T02:05:37.492875Z","end":"2026-04-20T02:05:37.626101Z","steps":["trace[184573390] 'process raft request'  (duration: 130.952327ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:16.314713Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530392807185720913,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-20T02:06:16.357572Z","caller":"traceutil/trace.go:171","msg":"trace[1414130620] transaction","detail":"{read_only:false; response_revision:3998; number_of_response:1; }","duration":"590.705687ms","start":"2026-04-20T02:06:15.766848Z","end":"2026-04-20T02:06:16.357554Z","steps":["trace[1414130620] 'process raft request'  (duration: 590.434081ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:16.357675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:15.766811Z","time spent":"590.811779ms","remote":"127.0.0.1:59988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":451369,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/monitoring/sh.helm.release.v1.kube-prometheus-stack.v1\" mod_revision:3994 > success:<request_put:<key:\"/registry/secrets/monitoring/sh.helm.release.v1.kube-prometheus-stack.v1\" value_size:451287 >> failure:<request_range:<key:\"/registry/secrets/monitoring/sh.helm.release.v1.kube-prometheus-stack.v1\" > >"}
{"level":"info","ts":"2026-04-20T02:06:16.35816Z","caller":"traceutil/trace.go:171","msg":"trace[1655893983] transaction","detail":"{read_only:false; response_revision:3999; number_of_response:1; }","duration":"590.552434ms","start":"2026-04-20T02:06:15.767597Z","end":"2026-04-20T02:06:16.358149Z","steps":["trace[1655893983] 'process raft request'  (duration: 590.442592ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:16.358207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:15.767565Z","time spent":"590.618206ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:3983 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-20T02:06:16.358205Z","caller":"traceutil/trace.go:171","msg":"trace[938506409] transaction","detail":"{read_only:false; response_revision:4000; number_of_response:1; }","duration":"137.556204ms","start":"2026-04-20T02:06:16.220629Z","end":"2026-04-20T02:06:16.358185Z","steps":["trace[938506409] 'process raft request'  (duration: 137.484003ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:06:16.35842Z","caller":"traceutil/trace.go:171","msg":"trace[531912680] linearizableReadLoop","detail":"{readStateIndex:4166; appliedIndex:4162; }","duration":"544.791215ms","start":"2026-04-20T02:06:15.813619Z","end":"2026-04-20T02:06:16.35841Z","steps":["trace[531912680] 'read index received'  (duration: 543.674729ms)","trace[531912680] 'applied index is now lower than readState.Index'  (duration: 1.115146ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:06:16.358496Z","caller":"traceutil/trace.go:171","msg":"trace[1419352953] transaction","detail":"{read_only:false; response_revision:4001; number_of_response:1; }","duration":"135.842107ms","start":"2026-04-20T02:06:16.222644Z","end":"2026-04-20T02:06:16.358486Z","steps":["trace[1419352953] 'process raft request'  (duration: 135.494239ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:16.358577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.956909ms","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-20T02:06:16.358601Z","caller":"traceutil/trace.go:171","msg":"trace[748847967] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4001; }","duration":"545.01524ms","start":"2026-04-20T02:06:15.81358Z","end":"2026-04-20T02:06:16.358595Z","steps":["trace[748847967] 'agreement among raft nodes before linearized reading'  (duration: 544.914988ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:16.358617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:15.813559Z","time spent":"545.054562ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-20T02:06:16.358691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.24555ms","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-20T02:06:16.358707Z","caller":"traceutil/trace.go:171","msg":"trace[773136597] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4001; }","duration":"543.280671ms","start":"2026-04-20T02:06:15.815423Z","end":"2026-04-20T02:06:16.358703Z","steps":["trace[773136597] 'agreement among raft nodes before linearized reading'  (duration: 543.23763ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:16.358731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:15.815413Z","time spent":"543.315461ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-20T02:06:16.35884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.451706ms","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-20T02:06:16.358858Z","caller":"traceutil/trace.go:171","msg":"trace[1783375201] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:4001; }","duration":"256.470576ms","start":"2026-04-20T02:06:16.102382Z","end":"2026-04-20T02:06:16.358853Z","steps":["trace[1783375201] 'agreement among raft nodes before linearized reading'  (duration: 256.433185ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:16.358956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.276978ms","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-20T02:06:16.358973Z","caller":"traceutil/trace.go:171","msg":"trace[1057133768] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4001; }","duration":"542.306359ms","start":"2026-04-20T02:06:15.816663Z","end":"2026-04-20T02:06:16.358969Z","steps":["trace[1057133768] 'agreement among raft nodes before linearized reading'  (duration: 542.265178ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:16.358987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:15.816656Z","time spent":"542.325899ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-20T02:06:16.359028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.443625ms","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-20T02:06:16.359073Z","caller":"traceutil/trace.go:171","msg":"trace[2101017259] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4001; }","duration":"543.526517ms","start":"2026-04-20T02:06:15.815528Z","end":"2026-04-20T02:06:16.359055Z","steps":["trace[2101017259] 'agreement among raft nodes before linearized reading'  (duration: 543.412924ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:16.359114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:15.815508Z","time spent":"543.598308ms","remote":"127.0.0.1:57262","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":"info","ts":"2026-04-20T02:06:23.393599Z","caller":"traceutil/trace.go:171","msg":"trace[855846096] transaction","detail":"{read_only:false; response_revision:4345; number_of_response:1; }","duration":"117.37413ms","start":"2026-04-20T02:06:23.276205Z","end":"2026-04-20T02:06:23.393579Z","steps":["trace[855846096] 'process raft request'  (duration: 116.94063ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:06:23.3961Z","caller":"traceutil/trace.go:171","msg":"trace[725108612] transaction","detail":"{read_only:false; response_revision:4346; number_of_response:1; }","duration":"119.741994ms","start":"2026-04-20T02:06:23.276348Z","end":"2026-04-20T02:06:23.39609Z","steps":["trace[725108612] 'process raft request'  (duration: 119.334505ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:24.03075Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530392807185721375,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-20T02:06:24.531676Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530392807185721375,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-20T02:06:24.766698Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.256117558s","expected-duration":"1s"}
{"level":"info","ts":"2026-04-20T02:06:24.770235Z","caller":"traceutil/trace.go:171","msg":"trace[2033808278] transaction","detail":"{read_only:false; response_revision:4351; number_of_response:1; }","duration":"1.259052315s","start":"2026-04-20T02:06:23.510496Z","end":"2026-04-20T02:06:24.769548Z","steps":["trace[2033808278] 'process raft request'  (duration: 1.256558278s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:24.770575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:23.51048Z","time spent":"1.259935795s","remote":"127.0.0.1:35028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2745,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/cert-manager.io/certificates/monitoring/grafana-tls\" mod_revision:4344 > success:<request_put:<key:\"/registry/cert-manager.io/certificates/monitoring/grafana-tls\" value_size:2676 >> failure:<request_range:<key:\"/registry/cert-manager.io/certificates/monitoring/grafana-tls\" > >"}
{"level":"info","ts":"2026-04-20T02:06:24.823982Z","caller":"traceutil/trace.go:171","msg":"trace[666229221] transaction","detail":"{read_only:false; response_revision:4352; number_of_response:1; }","duration":"1.297273784s","start":"2026-04-20T02:06:23.526644Z","end":"2026-04-20T02:06:24.823918Z","steps":["trace[666229221] 'process raft request'  (duration: 1.296905865s)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:06:24.824316Z","caller":"traceutil/trace.go:171","msg":"trace[607230448] transaction","detail":"{read_only:false; response_revision:4353; number_of_response:1; }","duration":"1.248165789s","start":"2026-04-20T02:06:23.576123Z","end":"2026-04-20T02:06:24.824289Z","steps":["trace[607230448] 'process raft request'  (duration: 1.247560735s)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:06:24.82437Z","caller":"traceutil/trace.go:171","msg":"trace[1374714404] transaction","detail":"{read_only:false; response_revision:4354; number_of_response:1; }","duration":"1.227219561s","start":"2026-04-20T02:06:23.59712Z","end":"2026-04-20T02:06:24.824339Z","steps":["trace[1374714404] 'process raft request'  (duration: 1.22674403s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:24.824505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:23.576104Z","time spent":"1.248318512s","remote":"127.0.0.1:59974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":809,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/monitoring/alertmanager-tls-r7649.18a7ee796167f757\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/alertmanager-tls-r7649.18a7ee796167f757\" value_size:724 lease:6530392807185720093 >> failure:<>"}
{"level":"warn","ts":"2026-04-20T02:06:24.824622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:23.597098Z","time spent":"1.227329734s","remote":"127.0.0.1:59988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":451469,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/monitoring/sh.helm.release.v1.kube-prometheus-stack.v1\" mod_revision:4345 > success:<request_put:<key:\"/registry/secrets/monitoring/sh.helm.release.v1.kube-prometheus-stack.v1\" value_size:451387 >> failure:<request_range:<key:\"/registry/secrets/monitoring/sh.helm.release.v1.kube-prometheus-stack.v1\" > >"}
{"level":"warn","ts":"2026-04-20T02:06:24.824793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:23.526612Z","time spent":"1.297463339s","remote":"127.0.0.1:59974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":802,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/monitoring/alertmanager-tls-r7649.18a7ee79617af860\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/alertmanager-tls-r7649.18a7ee79617af860\" value_size:717 lease:6530392807185720093 >> failure:<>"}
{"level":"info","ts":"2026-04-20T02:06:24.831405Z","caller":"traceutil/trace.go:171","msg":"trace[236285930] transaction","detail":"{read_only:false; response_revision:4355; number_of_response:1; }","duration":"1.160170706s","start":"2026-04-20T02:06:23.671212Z","end":"2026-04-20T02:06:24.831383Z","steps":["trace[236285930] 'process raft request'  (duration: 1.159715315s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:24.831554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:23.671184Z","time spent":"1.160289499s","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:4050 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-04-20T02:06:24.832043Z","caller":"traceutil/trace.go:171","msg":"trace[177242760] transaction","detail":"{read_only:false; response_revision:4356; number_of_response:1; }","duration":"449.662951ms","start":"2026-04-20T02:06:24.382368Z","end":"2026-04-20T02:06:24.832031Z","steps":["trace[177242760] 'process raft request'  (duration: 448.882123ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:24.832108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:24.38234Z","time spent":"449.738173ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:4067 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-20T02:06:24.83243Z","caller":"traceutil/trace.go:171","msg":"trace[413154991] transaction","detail":"{read_only:false; response_revision:4357; number_of_response:1; }","duration":"448.415863ms","start":"2026-04-20T02:06:24.384004Z","end":"2026-04-20T02:06:24.832419Z","steps":["trace[413154991] 'process raft request'  (duration: 447.952482ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:24.832494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:24.383989Z","time spent":"448.474204ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:4068 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-04-20T02:06:24.832698Z","caller":"traceutil/trace.go:171","msg":"trace[1511223627] linearizableReadLoop","detail":"{readStateIndex:4530; appliedIndex:4521; }","duration":"1.302018313s","start":"2026-04-20T02:06:23.530667Z","end":"2026-04-20T02:06:24.832685Z","steps":["trace[1511223627] 'read index received'  (duration: 1.236506852s)","trace[1511223627] 'applied index is now lower than readState.Index'  (duration: 65.510801ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:06:24.832814Z","caller":"traceutil/trace.go:171","msg":"trace[735172139] transaction","detail":"{read_only:false; response_revision:4358; number_of_response:1; }","duration":"441.578588ms","start":"2026-04-20T02:06:24.391228Z","end":"2026-04-20T02:06:24.832807Z","steps":["trace[735172139] 'process raft request'  (duration: 441.150148ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:24.832976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:24.391214Z","time spent":"441.63858ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:4071 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-20T02:06:24.833118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.204607617s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-tls\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:06:24.833154Z","caller":"traceutil/trace.go:171","msg":"trace[521285786] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-tls; range_end:; response_count:0; response_revision:4359; }","duration":"1.204672498s","start":"2026-04-20T02:06:23.628474Z","end":"2026-04-20T02:06:24.833146Z","steps":["trace[521285786] 'agreement among raft nodes before linearized reading'  (duration: 1.204605927s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:24.833176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:23.628459Z","time spent":"1.2047123s","remote":"127.0.0.1:59988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/monitoring/prometheus-tls\" "}
{"level":"warn","ts":"2026-04-20T02:06:24.833298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.515933ms","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-20T02:06:24.833327Z","caller":"traceutil/trace.go:171","msg":"trace[1243619474] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4359; }","duration":"404.546714ms","start":"2026-04-20T02:06:24.428775Z","end":"2026-04-20T02:06:24.833321Z","steps":["trace[1243619474] 'agreement among raft nodes before linearized reading'  (duration: 404.431162ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:24.833325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.869839ms","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-20T02:06:24.833346Z","caller":"traceutil/trace.go:171","msg":"trace[1831271720] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4359; }","duration":"410.922641ms","start":"2026-04-20T02:06:24.422417Z","end":"2026-04-20T02:06:24.83334Z","steps":["trace[1831271720] 'agreement among raft nodes before linearized reading'  (duration: 410.835769ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:24.833358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:24.428717Z","time spent":"404.635577ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-20T02:06:24.83337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:24.422405Z","time spent":"410.959991ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-20T02:06:24.833442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.30277205s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:06:24.833463Z","caller":"traceutil/trace.go:171","msg":"trace[1999912711] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:4359; }","duration":"1.302825471s","start":"2026-04-20T02:06:23.530631Z","end":"2026-04-20T02:06:24.833457Z","steps":["trace[1999912711] 'agreement among raft nodes before linearized reading'  (duration: 1.30277526s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:24.833497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:23.530613Z","time spent":"1.302877473s","remote":"127.0.0.1:42124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "}
{"level":"warn","ts":"2026-04-20T02:06:24.833505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.816689ms","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-20T02:06:24.83353Z","caller":"traceutil/trace.go:171","msg":"trace[1681231541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4359; }","duration":"425.85692ms","start":"2026-04-20T02:06:24.407665Z","end":"2026-04-20T02:06:24.833522Z","steps":["trace[1681231541] 'agreement among raft nodes before linearized reading'  (duration: 425.785358ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:24.833561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:24.407657Z","time spent":"425.89817ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-20T02:06:24.833626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.467422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:06:24.833671Z","caller":"traceutil/trace.go:171","msg":"trace[182064692] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4359; }","duration":"135.544124ms","start":"2026-04-20T02:06:24.698121Z","end":"2026-04-20T02:06:24.833665Z","steps":["trace[182064692] 'agreement among raft nodes before linearized reading'  (duration: 135.482702ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:24.833694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.779204ms","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-20T02:06:24.833717Z","caller":"traceutil/trace.go:171","msg":"trace[2089051778] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4359; }","duration":"431.823846ms","start":"2026-04-20T02:06:24.401887Z","end":"2026-04-20T02:06:24.833711Z","steps":["trace[2089051778] 'agreement among raft nodes before linearized reading'  (duration: 431.753684ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:24.833743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:24.401875Z","time spent":"431.863546ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-20T02:06:24.833817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.692013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-20T02:06:24.833841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"918.620862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-20T02:06:24.833839Z","caller":"traceutil/trace.go:171","msg":"trace[2137418505] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:4359; }","duration":"348.745155ms","start":"2026-04-20T02:06:24.485088Z","end":"2026-04-20T02:06:24.833833Z","steps":["trace[2137418505] 'agreement among raft nodes before linearized reading'  (duration: 348.709164ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:06:24.833863Z","caller":"traceutil/trace.go:171","msg":"trace[1023680826] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:4359; }","duration":"918.680813ms","start":"2026-04-20T02:06:23.915176Z","end":"2026-04-20T02:06:24.833857Z","steps":["trace[1023680826] 'agreement among raft nodes before linearized reading'  (duration: 918.639612ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:24.833873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:24.485077Z","time spent":"348.789085ms","remote":"127.0.0.1:42130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "}
{"level":"warn","ts":"2026-04-20T02:06:24.833887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:23.915149Z","time spent":"918.732054ms","remote":"127.0.0.1:57436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "}
{"level":"warn","ts":"2026-04-20T02:06:24.833999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.676802ms","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-20T02:06:24.834019Z","caller":"traceutil/trace.go:171","msg":"trace[1001347649] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4359; }","duration":"402.721674ms","start":"2026-04-20T02:06:24.431292Z","end":"2026-04-20T02:06:24.834014Z","steps":["trace[1001347649] 'agreement among raft nodes before linearized reading'  (duration: 402.665732ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:24.834053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:24.43128Z","time spent":"402.765814ms","remote":"127.0.0.1:57262","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-20T02:06:24.834082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.157770011s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-tls\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:06:24.834119Z","caller":"traceutil/trace.go:171","msg":"trace[958193884] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-tls; range_end:; response_count:0; response_revision:4359; }","duration":"1.157837823s","start":"2026-04-20T02:06:23.676273Z","end":"2026-04-20T02:06:24.834111Z","steps":["trace[958193884] 'agreement among raft nodes before linearized reading'  (duration: 1.157778041s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:24.834145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:23.676259Z","time spent":"1.157880893s","remote":"127.0.0.1:59988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/monitoring/alertmanager-tls\" "}
{"level":"warn","ts":"2026-04-20T02:06:27.004867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.103479117s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"}
{"level":"info","ts":"2026-04-20T02:06:27.004998Z","caller":"traceutil/trace.go:171","msg":"trace[1510578443] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:4394; }","duration":"1.103648911s","start":"2026-04-20T02:06:25.901327Z","end":"2026-04-20T02:06:27.004976Z","steps":["trace[1510578443] 'range keys from in-memory index tree'  (duration: 1.103300583s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:27.00505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:25.901312Z","time spent":"1.103724993s","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5674,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-04-20T02:06:27.005005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.450519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:06:27.005138Z","caller":"traceutil/trace.go:171","msg":"trace[663107771] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:4394; }","duration":"579.684665ms","start":"2026-04-20T02:06:26.42543Z","end":"2026-04-20T02:06:27.005114Z","steps":["trace[663107771] 'count revisions from in-memory index tree'  (duration: 579.348477ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:27.005282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:26.425412Z","time spent":"579.815738ms","remote":"127.0.0.1:35032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "}
{"level":"warn","ts":"2026-04-20T02:06:27.005514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.011621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:06:27.005651Z","caller":"traceutil/trace.go:171","msg":"trace[1638945857] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4394; }","duration":"308.196725ms","start":"2026-04-20T02:06:26.697437Z","end":"2026-04-20T02:06:27.005633Z","steps":["trace[1638945857] 'range keys from in-memory index tree'  (duration: 307.94409ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:27.005694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:06:26.697418Z","time spent":"308.265616ms","remote":"127.0.0.1:59910","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-20T02:06:27.005652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.830403ms","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-20T02:06:27.005749Z","caller":"traceutil/trace.go:171","msg":"trace[1408898918] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4394; }","duration":"190.932206ms","start":"2026-04-20T02:06:26.814805Z","end":"2026-04-20T02:06:27.005737Z","steps":["trace[1408898918] 'range keys from in-memory index tree'  (duration: 190.806593ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:27.005988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.070548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-04-20T02:06:27.006052Z","caller":"traceutil/trace.go:171","msg":"trace[2027715175] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:4394; }","duration":"187.16628ms","start":"2026-04-20T02:06:26.818868Z","end":"2026-04-20T02:06:27.006034Z","steps":["trace[2027715175] 'range keys from in-memory index tree'  (duration: 186.926956ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:06:27.006258Z","caller":"traceutil/trace.go:171","msg":"trace[1405820512] transaction","detail":"{read_only:false; response_revision:4395; number_of_response:1; }","duration":"163.806999ms","start":"2026-04-20T02:06:26.842439Z","end":"2026-04-20T02:06:27.006246Z","steps":["trace[1405820512] 'process raft request'  (duration: 161.178419ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:06:27.006618Z","caller":"traceutil/trace.go:171","msg":"trace[2068199637] transaction","detail":"{read_only:false; response_revision:4396; number_of_response:1; }","duration":"163.294118ms","start":"2026-04-20T02:06:26.843309Z","end":"2026-04-20T02:06:27.006603Z","steps":["trace[2068199637] 'process raft request'  (duration: 163.100204ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:06:27.00683Z","caller":"traceutil/trace.go:171","msg":"trace[1301123523] transaction","detail":"{read_only:false; response_revision:4397; number_of_response:1; }","duration":"163.054462ms","start":"2026-04-20T02:06:26.843755Z","end":"2026-04-20T02:06:27.006809Z","steps":["trace[1301123523] 'process raft request'  (duration: 162.787236ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:06:27.007116Z","caller":"traceutil/trace.go:171","msg":"trace[1976138210] linearizableReadLoop","detail":"{readStateIndex:4574; appliedIndex:4570; }","duration":"155.253533ms","start":"2026-04-20T02:06:26.85185Z","end":"2026-04-20T02:06:27.007103Z","steps":["trace[1976138210] 'read index received'  (duration: 151.780374ms)","trace[1976138210] 'applied index is now lower than readState.Index'  (duration: 3.471799ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:06:27.007218Z","caller":"traceutil/trace.go:171","msg":"trace[1691147279] transaction","detail":"{read_only:false; response_revision:4398; number_of_response:1; }","duration":"161.955217ms","start":"2026-04-20T02:06:26.845248Z","end":"2026-04-20T02:06:27.007204Z","steps":["trace[1691147279] 'process raft request'  (duration: 161.506966ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:27.00735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.477298ms","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-20T02:06:27.007387Z","caller":"traceutil/trace.go:171","msg":"trace[574776244] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4398; }","duration":"155.542089ms","start":"2026-04-20T02:06:26.851835Z","end":"2026-04-20T02:06:27.007377Z","steps":["trace[574776244] 'agreement among raft nodes before linearized reading'  (duration: 155.378286ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:27.007539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.697019ms","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-20T02:06:27.007586Z","caller":"traceutil/trace.go:171","msg":"trace[1188091778] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4398; }","duration":"153.75593ms","start":"2026-04-20T02:06:26.853818Z","end":"2026-04-20T02:06:27.007574Z","steps":["trace[1188091778] 'agreement among raft nodes before linearized reading'  (duration: 153.637727ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:27.007734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.550215ms","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-20T02:06:27.007773Z","caller":"traceutil/trace.go:171","msg":"trace[671857420] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4398; }","duration":"146.628217ms","start":"2026-04-20T02:06:26.861135Z","end":"2026-04-20T02:06:27.007763Z","steps":["trace[671857420] 'agreement among raft nodes before linearized reading'  (duration: 146.519155ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:27.007844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.035977ms","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-20T02:06:27.007887Z","caller":"traceutil/trace.go:171","msg":"trace[1231349741] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4398; }","duration":"154.095128ms","start":"2026-04-20T02:06:26.853781Z","end":"2026-04-20T02:06:27.007877Z","steps":["trace[1231349741] 'agreement among raft nodes before linearized reading'  (duration: 153.890883ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:27.008833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.790256ms","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-20T02:06:27.009172Z","caller":"traceutil/trace.go:171","msg":"trace[1772580756] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4398; }","duration":"156.198315ms","start":"2026-04-20T02:06:26.85295Z","end":"2026-04-20T02:06:27.009148Z","steps":["trace[1772580756] 'agreement among raft nodes before linearized reading'  (duration: 154.296211ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:06:41.180292Z","caller":"traceutil/trace.go:171","msg":"trace[1764294343] transaction","detail":"{read_only:false; response_revision:4712; number_of_response:1; }","duration":"117.01697ms","start":"2026-04-20T02:06:41.063245Z","end":"2026-04-20T02:06:41.180262Z","steps":["trace[1764294343] 'process raft request'  (duration: 116.812505ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:06:41.199097Z","caller":"traceutil/trace.go:171","msg":"trace[556449440] transaction","detail":"{read_only:false; response_revision:4713; number_of_response:1; }","duration":"129.533506ms","start":"2026-04-20T02:06:41.069536Z","end":"2026-04-20T02:06:41.199069Z","steps":["trace[556449440] 'process raft request'  (duration: 129.357722ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:06:41.199965Z","caller":"traceutil/trace.go:171","msg":"trace[1402229966] transaction","detail":"{read_only:false; response_revision:4714; number_of_response:1; }","duration":"130.256272ms","start":"2026-04-20T02:06:41.069666Z","end":"2026-04-20T02:06:41.199922Z","steps":["trace[1402229966] 'process raft request'  (duration: 129.361242ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:06:41.200546Z","caller":"traceutil/trace.go:171","msg":"trace[1720099911] linearizableReadLoop","detail":"{readStateIndex:4897; appliedIndex:4893; }","duration":"129.16844ms","start":"2026-04-20T02:06:41.071334Z","end":"2026-04-20T02:06:41.200502Z","steps":["trace[1720099911] 'read index received'  (duration: 108.779113ms)","trace[1720099911] 'applied index is now lower than readState.Index'  (duration: 20.384576ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:06:41.20077Z","caller":"traceutil/trace.go:171","msg":"trace[1280041328] transaction","detail":"{read_only:false; response_revision:4715; number_of_response:1; }","duration":"130.206812ms","start":"2026-04-20T02:06:41.07054Z","end":"2026-04-20T02:06:41.200747Z","steps":["trace[1280041328] 'process raft request'  (duration: 129.295361ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:41.200844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.491837ms","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-20T02:06:41.200895Z","caller":"traceutil/trace.go:171","msg":"trace[178119019] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4715; }","duration":"129.579588ms","start":"2026-04-20T02:06:41.071302Z","end":"2026-04-20T02:06:41.200882Z","steps":["trace[178119019] 'agreement among raft nodes before linearized reading'  (duration: 129.418384ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:41.201113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.207505ms","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-20T02:06:41.201159Z","caller":"traceutil/trace.go:171","msg":"trace[1210336873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4715; }","duration":"113.341307ms","start":"2026-04-20T02:06:41.087807Z","end":"2026-04-20T02:06:41.201148Z","steps":["trace[1210336873] 'agreement among raft nodes before linearized reading'  (duration: 113.203014ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:41.20129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.412139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-04-20T02:06:41.201368Z","caller":"traceutil/trace.go:171","msg":"trace[1162994927] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4715; }","duration":"113.511842ms","start":"2026-04-20T02:06:41.087846Z","end":"2026-04-20T02:06:41.201358Z","steps":["trace[1162994927] 'agreement among raft nodes before linearized reading'  (duration: 113.371159ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:41.201497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.326846ms","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-20T02:06:41.201529Z","caller":"traceutil/trace.go:171","msg":"trace[757397398] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4715; }","duration":"116.379327ms","start":"2026-04-20T02:06:41.085142Z","end":"2026-04-20T02:06:41.201521Z","steps":["trace[757397398] 'agreement among raft nodes before linearized reading'  (duration: 116.301675ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:06:41.201499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.627559ms","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-20T02:06:41.202389Z","caller":"traceutil/trace.go:171","msg":"trace[1741154214] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4715; }","duration":"119.803875ms","start":"2026-04-20T02:06:41.082548Z","end":"2026-04-20T02:06:41.202352Z","steps":["trace[1741154214] 'agreement among raft nodes before linearized reading'  (duration: 118.22573ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:06:43.297926Z","caller":"traceutil/trace.go:171","msg":"trace[1596244940] transaction","detail":"{read_only:false; response_revision:4752; number_of_response:1; }","duration":"110.608746ms","start":"2026-04-20T02:06:43.187294Z","end":"2026-04-20T02:06:43.297903Z","steps":["trace[1596244940] 'process raft request'  (duration: 110.468073ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:06:54.73773Z","caller":"traceutil/trace.go:171","msg":"trace[259208523] transaction","detail":"{read_only:false; response_revision:4899; number_of_response:1; }","duration":"113.489086ms","start":"2026-04-20T02:06:54.624219Z","end":"2026-04-20T02:06:54.737708Z","steps":["trace[259208523] 'process raft request'  (duration: 113.115688ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:08:14.711865Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2879}
{"level":"info","ts":"2026-04-20T02:08:14.817667Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2879,"took":"104.3917ms","hash":3044020274,"current-db-size-bytes":53583872,"current-db-size":"54 MB","current-db-size-in-use-bytes":28856320,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-04-20T02:08:14.817775Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3044020274,"revision":2879,"compact-revision":-1}
{"level":"warn","ts":"2026-04-20T02:11:01.067657Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530392807185727168,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-20T02:11:01.189583Z","caller":"traceutil/trace.go:171","msg":"trace[1865539473] transaction","detail":"{read_only:false; response_revision:6689; number_of_response:1; }","duration":"729.25241ms","start":"2026-04-20T02:11:00.460306Z","end":"2026-04-20T02:11:01.189558Z","steps":["trace[1865539473] 'process raft request'  (duration: 729.009554ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:11:01.190252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:11:00.460278Z","time spent":"729.496866ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:6679 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-04-20T02:11:01.196629Z","caller":"traceutil/trace.go:171","msg":"trace[822319951] linearizableReadLoop","detail":"{readStateIndex:6940; appliedIndex:6937; }","duration":"629.833079ms","start":"2026-04-20T02:11:00.566749Z","end":"2026-04-20T02:11:01.196582Z","steps":["trace[822319951] 'read index received'  (duration: 625.500837ms)","trace[822319951] 'applied index is now lower than readState.Index'  (duration: 4.331132ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:11:01.197012Z","caller":"traceutil/trace.go:171","msg":"trace[338813348] transaction","detail":"{read_only:false; response_revision:6690; number_of_response:1; }","duration":"732.178478ms","start":"2026-04-20T02:11:00.464821Z","end":"2026-04-20T02:11:01.196999Z","steps":["trace[338813348] 'process raft request'  (duration: 731.612375ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:11:01.197418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.658877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:11:01.197473Z","caller":"traceutil/trace.go:171","msg":"trace[1018108804] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:6692; }","duration":"630.779811ms","start":"2026-04-20T02:11:00.566679Z","end":"2026-04-20T02:11:01.197459Z","steps":["trace[1018108804] 'agreement among raft nodes before linearized reading'  (duration: 630.688219ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:11:01.19755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:11:00.566656Z","time spent":"630.882772ms","remote":"127.0.0.1:57946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true "}
{"level":"info","ts":"2026-04-20T02:11:01.198068Z","caller":"traceutil/trace.go:171","msg":"trace[1283636909] transaction","detail":"{read_only:false; response_revision:6691; number_of_response:1; }","duration":"732.696229ms","start":"2026-04-20T02:11:00.465357Z","end":"2026-04-20T02:11:01.198054Z","steps":["trace[1283636909] 'process raft request'  (duration: 731.156664ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:11:01.198307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:11:00.465341Z","time spent":"732.763681ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:6680 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-04-20T02:11:01.198583Z","caller":"traceutil/trace.go:171","msg":"trace[1787094408] transaction","detail":"{read_only:false; response_revision:6692; number_of_response:1; }","duration":"707.481493ms","start":"2026-04-20T02:11:00.491092Z","end":"2026-04-20T02:11:01.198574Z","steps":["trace[1787094408] 'process raft request'  (duration: 705.454807ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:11:01.198619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:11:00.491023Z","time spent":"707.579076ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:6682 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-20T02:11:01.199045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.146477ms","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-20T02:11:01.199067Z","caller":"traceutil/trace.go:171","msg":"trace[1247721790] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6692; }","duration":"397.212258ms","start":"2026-04-20T02:11:00.801851Z","end":"2026-04-20T02:11:01.199063Z","steps":["trace[1247721790] 'agreement among raft nodes before linearized reading'  (duration: 397.174368ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:11:01.199082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:11:00.801824Z","time spent":"397.254759ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-20T02:11:01.199446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.396691ms","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-20T02:11:01.199468Z","caller":"traceutil/trace.go:171","msg":"trace[1166047661] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6692; }","duration":"375.441942ms","start":"2026-04-20T02:11:00.824021Z","end":"2026-04-20T02:11:01.199463Z","steps":["trace[1166047661] 'agreement among raft nodes before linearized reading'  (duration: 375.352329ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:11:01.199594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:11:00.824015Z","time spent":"375.464042ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-20T02:11:01.199698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.389764ms","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-20T02:11:01.19975Z","caller":"traceutil/trace.go:171","msg":"trace[1959727906] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6692; }","duration":"379.454796ms","start":"2026-04-20T02:11:00.82029Z","end":"2026-04-20T02:11:01.199745Z","steps":["trace[1959727906] 'agreement among raft nodes before linearized reading'  (duration: 379.332053ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:11:01.199766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:11:00.820285Z","time spent":"379.476456ms","remote":"127.0.0.1:57262","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-20T02:11:01.200311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.101691ms","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-20T02:11:01.200333Z","caller":"traceutil/trace.go:171","msg":"trace[1774639031] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6692; }","duration":"380.140461ms","start":"2026-04-20T02:11:00.820187Z","end":"2026-04-20T02:11:01.200328Z","steps":["trace[1774639031] 'agreement among raft nodes before linearized reading'  (duration: 380.08538ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:11:01.200403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:11:00.820182Z","time spent":"380.161142ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-20T02:11:01.200612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.440368ms","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-20T02:11:01.200631Z","caller":"traceutil/trace.go:171","msg":"trace[2045997921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6692; }","duration":"380.485819ms","start":"2026-04-20T02:11:00.820142Z","end":"2026-04-20T02:11:01.200627Z","steps":["trace[2045997921] 'agreement among raft nodes before linearized reading'  (duration: 380.436798ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:11:01.200709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:11:00.82013Z","time spent":"380.51172ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-20T02:11:01.201243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:11:00.464789Z","time spent":"732.26014ms","remote":"127.0.0.1:57262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:6681 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-20T02:13:14.718935Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5546}
{"level":"info","ts":"2026-04-20T02:13:14.811591Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5546,"took":"90.824759ms","hash":583340197,"current-db-size-bytes":53583872,"current-db-size":"54 MB","current-db-size-in-use-bytes":18178048,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-04-20T02:13:14.811682Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":583340197,"revision":5546,"compact-revision":2879}