{"level":"warn","ts":"2026-05-21T14:49:19.694563Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-21T14:49:19.694875Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.115: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.115:2380","--initial-cluster=instance=https://199.204.45.115:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.115:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.115:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-21T14:49:19.695257Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-21T14:49:19.695308Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-05-21T14:49:19.695351Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-21T14:49:19.696273Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"]} {"level":"info","ts":"2026-05-21T14:49:19.696421Z","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.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.115:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-21T14:49:19.70459Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.285316ms"} {"level":"info","ts":"2026-05-21T14:49:19.714523Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3aaa5c123e150e0","cluster-id":"61ec519698823541"} {"level":"info","ts":"2026-05-21T14:49:19.714947Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=()"} {"level":"info","ts":"2026-05-21T14:49:19.715073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 0"} {"level":"info","ts":"2026-05-21T14:49:19.715171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3aaa5c123e150e0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-21T14:49:19.715252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 1"} {"level":"info","ts":"2026-05-21T14:49:19.715356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"warn","ts":"2026-05-21T14:49:19.725045Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-21T14:49:19.727489Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-21T14:49:19.730366Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-21T14:49:19.732734Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3aaa5c123e150e0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-21T14:49:19.732925Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3aaa5c123e150e0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-21T14:49:19.733156Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-21T14:49:19.733259Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-21T14:49:19.733293Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-21T14:49:19.733821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"info","ts":"2026-05-21T14:49:19.733952Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","added-peer-id":"e3aaa5c123e150e0","added-peer-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-05-21T14:49:19.736641Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-21T14:49:19.736838Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-05-21T14:49:19.736908Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-05-21T14:49:19.736939Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3aaa5c123e150e0","initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-21T14:49:19.736993Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-21T14:49:20.715863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 is starting a new election at term 1"} {"level":"info","ts":"2026-05-21T14:49:20.715917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-21T14:49:20.71595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgPreVoteResp from e3aaa5c123e150e0 at term 1"} {"level":"info","ts":"2026-05-21T14:49:20.715964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became candidate at term 2"} {"level":"info","ts":"2026-05-21T14:49:20.715971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgVoteResp from e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-05-21T14:49:20.715981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became leader at term 2"} {"level":"info","ts":"2026-05-21T14:49:20.715994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3aaa5c123e150e0 elected leader e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-05-21T14:49:20.726376Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3aaa5c123e150e0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.115:2379]}","request-path":"/0/members/e3aaa5c123e150e0/attributes","cluster-id":"61ec519698823541","publish-timeout":"7s"} {"level":"info","ts":"2026-05-21T14:49:20.726431Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-21T14:49:20.726516Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T14:49:20.726605Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-21T14:49:20.72676Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-21T14:49:20.726815Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-21T14:49:20.728172Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T14:49:20.729131Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T14:49:20.729217Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T14:49:20.730055Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.115:2379"} {"level":"info","ts":"2026-05-21T14:49:20.7307Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-21T14:49:59.067719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.928498ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-21T14:49:59.068109Z","caller":"traceutil/trace.go:171","msg":"trace[889558890] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"703.024945ms","start":"2026-05-21T14:49:58.36505Z","end":"2026-05-21T14:49:59.068075Z","steps":["trace[889558890] 'process raft request' (duration: 341.209231ms)","trace[889558890] 'compare' (duration: 360.767306ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T14:49:59.068213Z","caller":"traceutil/trace.go:171","msg":"trace[396704873] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"702.539917ms","start":"2026-05-21T14:49:58.365654Z","end":"2026-05-21T14:49:59.068194Z","steps":["trace[396704873] 'process raft request' (duration: 702.196751ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:49:59.068248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:49:58.365036Z","time spent":"703.148387ms","remote":"127.0.0.1:51486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-21T14:49:59.068303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:49:58.365648Z","time spent":"702.607378ms","remote":"127.0.0.1:51486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-21T14:49:59.068387Z","caller":"traceutil/trace.go:171","msg":"trace[1240468211] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"692.143412ms","start":"2026-05-21T14:49:58.376225Z","end":"2026-05-21T14:49:59.068369Z","steps":["trace[1240468211] 'process raft request' (duration: 692.052861ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:49:59.068405Z","caller":"traceutil/trace.go:171","msg":"trace[1344380008] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"702.301754ms","start":"2026-05-21T14:49:58.366091Z","end":"2026-05-21T14:49:59.068393Z","steps":["trace[1344380008] 'process raft request' (duration: 702.06787ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:49:59.068476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:49:58.376211Z","time spent":"692.223353ms","remote":"127.0.0.1:51486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-21T14:49:59.068638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:49:58.366083Z","time spent":"702.351004ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T14:49:59.068869Z","caller":"traceutil/trace.go:171","msg":"trace[1953222722] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"688.133815ms","start":"2026-05-21T14:49:58.380724Z","end":"2026-05-21T14:49:59.068858Z","steps":["trace[1953222722] 'process raft request' (duration: 687.603806ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:49:59.06892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:49:58.380709Z","time spent":"688.185066ms","remote":"127.0.0.1:51486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-21T14:49:59.068938Z","caller":"traceutil/trace.go:171","msg":"trace[163448006] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"688.015903ms","start":"2026-05-21T14:49:58.380906Z","end":"2026-05-21T14:49:59.068922Z","steps":["trace[163448006] 'process raft request' (duration: 687.780309ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:49:59.069002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:49:58.380894Z","time spent":"688.076624ms","remote":"127.0.0.1:51486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-21T14:49:59.06902Z","caller":"traceutil/trace.go:171","msg":"trace[1379189258] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"686.356455ms","start":"2026-05-21T14:49:58.382615Z","end":"2026-05-21T14:49:59.068971Z","steps":["trace[1379189258] 'process raft request' (duration: 686.214803ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:49:59.069073Z","caller":"traceutil/trace.go:171","msg":"trace[223090543] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"647.831168ms","start":"2026-05-21T14:49:58.42123Z","end":"2026-05-21T14:49:59.069061Z","steps":["trace[223090543] 'process raft request' (duration: 647.784657ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:49:59.069103Z","caller":"traceutil/trace.go:171","msg":"trace[1194878500] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"683.845653ms","start":"2026-05-21T14:49:58.385248Z","end":"2026-05-21T14:49:59.069094Z","steps":["trace[1194878500] 'process raft request' (duration: 683.620569ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:49:59.069139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:49:58.421197Z","time spent":"647.911619ms","remote":"127.0.0.1:51486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-21T14:49:59.069147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:49:58.385241Z","time spent":"683.884694ms","remote":"127.0.0.1:51486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-21T14:49:59.069192Z","caller":"traceutil/trace.go:171","msg":"trace[712924544] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"672.729277ms","start":"2026-05-21T14:49:58.396453Z","end":"2026-05-21T14:49:59.069182Z","steps":["trace[712924544] 'process raft request' (duration: 672.504863ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:49:59.069209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:49:58.382609Z","time spent":"686.505128ms","remote":"127.0.0.1:51486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-21T14:49:59.069244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:49:58.396426Z","time spent":"672.791757ms","remote":"127.0.0.1:51486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-21T14:49:59.069069Z","caller":"traceutil/trace.go:171","msg":"trace[1862358952] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"675.90464ms","start":"2026-05-21T14:49:58.393155Z","end":"2026-05-21T14:49:59.06906Z","steps":["trace[1862358952] 'process raft request' (duration: 675.755257ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:49:59.069328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:49:58.393149Z","time spent":"676.152894ms","remote":"127.0.0.1:51486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-21T14:49:59.156054Z","caller":"traceutil/trace.go:171","msg":"trace[1179422669] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"717.468579ms","start":"2026-05-21T14:49:58.438554Z","end":"2026-05-21T14:49:59.156023Z","steps":["trace[1179422669] 'process raft request' (duration: 717.203215ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:49:59.156218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:49:58.438534Z","time spent":"717.600382ms","remote":"127.0.0.1:51960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-21T14:49:59.156737Z","caller":"traceutil/trace.go:171","msg":"trace[132372808] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"718.14297ms","start":"2026-05-21T14:49:58.438554Z","end":"2026-05-21T14:49:59.156697Z","steps":["trace[132372808] 'process raft request' (duration: 717.396118ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:49:59.156834Z","caller":"traceutil/trace.go:171","msg":"trace[1528307363] transaction","detail":"{read_only:false; number_of_response:1; response_revision:539; }","duration":"718.175931ms","start":"2026-05-21T14:49:58.438619Z","end":"2026-05-21T14:49:59.156794Z","steps":["trace[1528307363] 'process raft request' (duration: 717.826085ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:49:59.156934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:49:58.438536Z","time spent":"718.291473ms","remote":"127.0.0.1:51486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T14:49:59.156974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:49:58.438613Z","time spent":"718.285473ms","remote":"127.0.0.1:51486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6937,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T14:49:59.157544Z","caller":"traceutil/trace.go:171","msg":"trace[1344289425] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"617.141285ms","start":"2026-05-21T14:49:58.540348Z","end":"2026-05-21T14:49:59.15749Z","steps":["trace[1344289425] 'process raft request' (duration: 616.170048ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:49:59.157614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:49:58.540327Z","time spent":"617.264527ms","remote":"127.0.0.1:51486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-21T14:49:59.176134Z","caller":"traceutil/trace.go:171","msg":"trace[2089964015] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"101.081623ms","start":"2026-05-21T14:49:59.075029Z","end":"2026-05-21T14:49:59.176111Z","steps":["trace[2089964015] 'process raft request' (duration: 100.369591ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:49:59.176877Z","caller":"traceutil/trace.go:171","msg":"trace[489648265] linearizableReadLoop","detail":"{readStateIndex:560; appliedIndex:555; }","duration":"342.242991ms","start":"2026-05-21T14:49:58.834599Z","end":"2026-05-21T14:49:59.176842Z","steps":["trace[489648265] 'read index received' (duration: 320.735056ms)","trace[489648265] 'applied index is now lower than readState.Index' (duration: 21.507125ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T14:49:59.177267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.65199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T14:49:59.179675Z","caller":"traceutil/trace.go:171","msg":"trace[881817341] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:549; }","duration":"342.757431ms","start":"2026-05-21T14:49:58.834552Z","end":"2026-05-21T14:49:59.17731Z","steps":["trace[881817341] 'agreement among raft nodes before linearized reading' (duration: 342.363284ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:49:59.179714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:49:58.834529Z","time spent":"345.173762ms","remote":"127.0.0.1:51426","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-05-21T14:50:04.439719Z","caller":"traceutil/trace.go:171","msg":"trace[567364490] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"144.547772ms","start":"2026-05-21T14:50:04.295146Z","end":"2026-05-21T14:50:04.439693Z","steps":["trace[567364490] 'process raft request' (duration: 144.375928ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:50:04.947386Z","caller":"traceutil/trace.go:171","msg":"trace[1833292986] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"570.295816ms","start":"2026-05-21T14:50:04.377054Z","end":"2026-05-21T14:50:04.94735Z","steps":["trace[1833292986] 'process raft request' (duration: 569.887069ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:50:04.947604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.990131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-77khn\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-21T14:50:04.947672Z","caller":"traceutil/trace.go:171","msg":"trace[855004619] range","detail":"{range_begin:/registry/pods/kube-system/cilium-77khn; range_end:; response_count:1; response_revision:621; }","duration":"273.098473ms","start":"2026-05-21T14:50:04.674555Z","end":"2026-05-21T14:50:04.947654Z","steps":["trace[855004619] 'agreement among raft nodes before linearized reading' (duration: 272.93115ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:50:04.947439Z","caller":"traceutil/trace.go:171","msg":"trace[1753420655] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"272.799178ms","start":"2026-05-21T14:50:04.67461Z","end":"2026-05-21T14:50:04.94741Z","steps":["trace[1753420655] 'read index received' (duration: 271.970633ms)","trace[1753420655] 'applied index is now lower than readState.Index' (duration: 824.275µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T14:50:04.947633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:50:04.377008Z","time spent":"570.570161ms","remote":"127.0.0.1:51520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036023,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-21T14:50:06.192605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.109357414s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T14:50:06.19272Z","caller":"traceutil/trace.go:171","msg":"trace[240590734] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"1.187429523s","start":"2026-05-21T14:50:05.005271Z","end":"2026-05-21T14:50:06.1927Z","steps":["trace[240590734] 'read index received' (duration: 77.883316ms)","trace[240590734] 'applied index is now lower than readState.Index' (duration: 1.109544777s)"],"step_count":2} {"level":"warn","ts":"2026-05-21T14:50:06.193044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.187731559s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T14:50:06.193082Z","caller":"traceutil/trace.go:171","msg":"trace[1393756694] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"1.229281977s","start":"2026-05-21T14:50:04.963774Z","end":"2026-05-21T14:50:06.193056Z","steps":["trace[1393756694] 'process raft request' (duration: 119.379093ms)","trace[1393756694] 'compare' (duration: 1.108745382s)"],"step_count":2} {"level":"info","ts":"2026-05-21T14:50:06.193123Z","caller":"traceutil/trace.go:171","msg":"trace[102951651] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:622; }","duration":"1.187884231s","start":"2026-05-21T14:50:05.005217Z","end":"2026-05-21T14:50:06.193101Z","steps":["trace[102951651] 'agreement among raft nodes before linearized reading' (duration: 1.187731989s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:50:06.193172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:50:05.005193Z","time spent":"1.187968804s","remote":"127.0.0.1:51636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-05-21T14:50:06.193203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.092456813s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-05-21T14:50:06.193218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:50:04.963751Z","time spent":"1.229396528s","remote":"127.0.0.1:51608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T14:50:06.193273Z","caller":"traceutil/trace.go:171","msg":"trace[1516370866] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:622; }","duration":"1.092569414s","start":"2026-05-21T14:50:05.10068Z","end":"2026-05-21T14:50:06.193249Z","steps":["trace[1516370866] 'agreement among raft nodes before linearized reading' (duration: 1.09235053s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:50:06.193329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:50:05.100668Z","time spent":"1.092646856s","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-21T14:50:06.19339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.265377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T14:50:06.193438Z","caller":"traceutil/trace.go:171","msg":"trace[87866829] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:622; }","duration":"358.385888ms","start":"2026-05-21T14:50:05.835038Z","end":"2026-05-21T14:50:06.193424Z","steps":["trace[87866829] 'agreement among raft nodes before linearized reading' (duration: 358.305977ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:50:06.193475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:50:05.835007Z","time spent":"358.45876ms","remote":"127.0.0.1:51426","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-05-21T14:50:06.193606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"812.285277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-21T14:50:06.193695Z","caller":"traceutil/trace.go:171","msg":"trace[2040874600] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:622; }","duration":"812.42104ms","start":"2026-05-21T14:50:05.381249Z","end":"2026-05-21T14:50:06.19367Z","steps":["trace[2040874600] 'agreement among raft nodes before linearized reading' (duration: 812.132245ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:50:06.193747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:50:05.381226Z","time spent":"812.508521ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-21T14:50:08.179927Z","caller":"traceutil/trace.go:171","msg":"trace[857118146] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"258.983144ms","start":"2026-05-21T14:50:07.92092Z","end":"2026-05-21T14:50:08.179903Z","steps":["trace[857118146] 'process raft request' (duration: 258.7322ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:51:12.263281Z","caller":"traceutil/trace.go:171","msg":"trace[1454319652] transaction","detail":"{read_only:false; response_revision:1454; number_of_response:1; }","duration":"127.860789ms","start":"2026-05-21T14:51:12.13537Z","end":"2026-05-21T14:51:12.26323Z","steps":["trace[1454319652] 'process raft request' (duration: 127.618162ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:51:12.308767Z","caller":"traceutil/trace.go:171","msg":"trace[582583854] transaction","detail":"{read_only:false; response_revision:1455; number_of_response:1; }","duration":"149.615089ms","start":"2026-05-21T14:51:12.159127Z","end":"2026-05-21T14:51:12.308742Z","steps":["trace[582583854] 'process raft request' (duration: 149.453914ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:37.614348Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831962830402049,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-21T14:51:37.776584Z","caller":"traceutil/trace.go:171","msg":"trace[2125231506] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"720.79657ms","start":"2026-05-21T14:51:37.055761Z","end":"2026-05-21T14:51:37.776557Z","steps":["trace[2125231506] 'process raft request' (duration: 720.598374ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:37.776861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:37.055734Z","time spent":"720.984226ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T14:51:38.212247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.704748ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T14:51:38.212475Z","caller":"traceutil/trace.go:171","msg":"trace[793276281] linearizableReadLoop","detail":"{readStateIndex:1955; appliedIndex:1952; }","duration":"1.098410105s","start":"2026-05-21T14:51:37.114048Z","end":"2026-05-21T14:51:38.212458Z","steps":["trace[793276281] 'read index received' (duration: 662.328944ms)","trace[793276281] 'applied index is now lower than readState.Index' (duration: 436.080141ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T14:51:38.212578Z","caller":"traceutil/trace.go:171","msg":"trace[241982517] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"318.105268ms","start":"2026-05-21T14:51:37.894441Z","end":"2026-05-21T14:51:38.212547Z","steps":["trace[241982517] 'process raft request' (duration: 317.983334ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:51:38.212596Z","caller":"traceutil/trace.go:171","msg":"trace[727567386] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"969.972885ms","start":"2026-05-21T14:51:37.24257Z","end":"2026-05-21T14:51:38.212542Z","steps":["trace[727567386] 'process raft request' (duration: 969.78107ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:38.212766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:37.894415Z","time spent":"318.261151ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T14:51:38.212815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:37.242546Z","time spent":"970.146481ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T14:51:38.212657Z","caller":"traceutil/trace.go:171","msg":"trace[986273329] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"1.1513472s","start":"2026-05-21T14:51:37.061153Z","end":"2026-05-21T14:51:38.2125Z","steps":["trace[986273329] 'process raft request' (duration: 1.000860689s)","trace[986273329] 'compare' (duration: 149.40322ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T14:51:38.213024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.096118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T14:51:38.213083Z","caller":"traceutil/trace.go:171","msg":"trace[1848874247] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1879; }","duration":"378.188181ms","start":"2026-05-21T14:51:37.834879Z","end":"2026-05-21T14:51:38.213067Z","steps":["trace[1848874247] 'agreement among raft nodes before linearized reading' (duration: 378.108798ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:38.213216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:37.834856Z","time spent":"378.342185ms","remote":"127.0.0.1:51434","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-05-21T14:51:38.21324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.844079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c37b0bf9-fd8b-47bb-a147-7ff99f9ec765\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-05-21T14:51:38.213255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.991804ms","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-05-21T14:51:38.213288Z","caller":"traceutil/trace.go:171","msg":"trace[928449454] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c37b0bf9-fd8b-47bb-a147-7ff99f9ec765; range_end:; response_count:1; response_revision:1879; }","duration":"292.960423ms","start":"2026-05-21T14:51:37.920312Z","end":"2026-05-21T14:51:38.213272Z","steps":["trace[928449454] 'agreement among raft nodes before linearized reading' (duration: 292.701425ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:51:38.213446Z","caller":"traceutil/trace.go:171","msg":"trace[773318792] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1879; }","duration":"255.240752ms","start":"2026-05-21T14:51:37.958073Z","end":"2026-05-21T14:51:38.213314Z","steps":["trace[773318792] 'agreement among raft nodes before linearized reading' (duration: 254.883961ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:38.213493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.099434354s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c37b0bf9-fd8b-47bb-a147-7ff99f9ec765\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-05-21T14:51:38.213757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.08586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T14:51:38.213816Z","caller":"traceutil/trace.go:171","msg":"trace[1446236786] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c37b0bf9-fd8b-47bb-a147-7ff99f9ec765; range_end:; response_count:1; response_revision:1879; }","duration":"1.099549207s","start":"2026-05-21T14:51:37.113996Z","end":"2026-05-21T14:51:38.213545Z","steps":["trace[1446236786] 'agreement among raft nodes before linearized reading' (duration: 1.098560329s)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:51:38.21384Z","caller":"traceutil/trace.go:171","msg":"trace[74186140] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1879; }","duration":"708.196933ms","start":"2026-05-21T14:51:37.505619Z","end":"2026-05-21T14:51:38.213816Z","steps":["trace[74186140] 'agreement among raft nodes before linearized reading' (duration: 708.08834ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:38.212776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.230259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-05-21T14:51:38.213908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:37.113973Z","time spent":"1.099911058s","remote":"127.0.0.1:51608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c37b0bf9-fd8b-47bb-a147-7ff99f9ec765\" "} {"level":"warn","ts":"2026-05-21T14:51:38.21393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:37.505601Z","time spent":"708.311237ms","remote":"127.0.0.1:51426","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-05-21T14:51:38.214004Z","caller":"traceutil/trace.go:171","msg":"trace[1754116143] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1879; }","duration":"804.455814ms","start":"2026-05-21T14:51:37.409489Z","end":"2026-05-21T14:51:38.213945Z","steps":["trace[1754116143] 'agreement among raft nodes before linearized reading' (duration: 803.089174ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:38.214523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:37.409469Z","time spent":"805.030281ms","remote":"127.0.0.1:40742","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-05-21T14:51:38.214362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:37.061128Z","time spent":"1.151906787s","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T14:51:39.225591Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831962830402058,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-21T14:51:39.318896Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.083348316s","expected-duration":"1s"} {"level":"info","ts":"2026-05-21T14:51:39.319525Z","caller":"traceutil/trace.go:171","msg":"trace[475743343] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"1.096464039s","start":"2026-05-21T14:51:38.223036Z","end":"2026-05-21T14:51:39.3195Z","steps":["trace[475743343] 'process raft request' (duration: 1.096313505s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:39.319681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:38.22298Z","time spent":"1.096610093s","remote":"127.0.0.1:51608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T14:51:39.463017Z","caller":"traceutil/trace.go:171","msg":"trace[538026632] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"1.064494262s","start":"2026-05-21T14:51:38.398486Z","end":"2026-05-21T14:51:39.462981Z","steps":["trace[538026632] 'process raft request' (duration: 1.064246045s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:39.463246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:38.398444Z","time spent":"1.064709618s","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T14:51:39.463031Z","caller":"traceutil/trace.go:171","msg":"trace[1194853902] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"865.716149ms","start":"2026-05-21T14:51:38.597282Z","end":"2026-05-21T14:51:39.462998Z","steps":["trace[1194853902] 'process raft request' (duration: 865.596715ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:39.463552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:38.597256Z","time spent":"866.207523ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T14:51:39.466008Z","caller":"traceutil/trace.go:171","msg":"trace[1199766114] linearizableReadLoop","detail":"{readStateIndex:1961; appliedIndex:1957; }","duration":"741.339701ms","start":"2026-05-21T14:51:38.724645Z","end":"2026-05-21T14:51:39.465984Z","steps":["trace[1199766114] 'read index received' (duration: 594.671855ms)","trace[1199766114] 'applied index is now lower than readState.Index' (duration: 146.666606ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T14:51:39.466253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.583719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-21T14:51:39.466292Z","caller":"traceutil/trace.go:171","msg":"trace[439017405] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1883; }","duration":"741.685832ms","start":"2026-05-21T14:51:38.724597Z","end":"2026-05-21T14:51:39.466282Z","steps":["trace[439017405] 'agreement among raft nodes before linearized reading' (duration: 741.512517ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:39.466329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:38.724576Z","time spent":"741.745213ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-21T14:51:39.466375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.047279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-21T14:51:39.466448Z","caller":"traceutil/trace.go:171","msg":"trace[907871178] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1883; }","duration":"538.137211ms","start":"2026-05-21T14:51:38.928293Z","end":"2026-05-21T14:51:39.466431Z","steps":["trace[907871178] 'agreement among raft nodes before linearized reading' (duration: 537.911234ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:39.4665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:38.928215Z","time spent":"538.276495ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-21T14:51:39.466621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.718155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-21T14:51:39.466682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.041259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-21T14:51:39.466705Z","caller":"traceutil/trace.go:171","msg":"trace[1705423561] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1883; }","duration":"243.079411ms","start":"2026-05-21T14:51:39.223618Z","end":"2026-05-21T14:51:39.466698Z","steps":["trace[1705423561] 'agreement among raft nodes before linearized reading' (duration: 242.986518ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:51:39.466804Z","caller":"traceutil/trace.go:171","msg":"trace[566539050] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1883; }","duration":"700.968402ms","start":"2026-05-21T14:51:38.765711Z","end":"2026-05-21T14:51:39.46668Z","steps":["trace[566539050] 'agreement among raft nodes before linearized reading' (duration: 700.508178ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:39.466853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:38.765663Z","time spent":"701.178958ms","remote":"127.0.0.1:51694","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-05-21T14:51:39.466991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.343856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T14:51:39.467027Z","caller":"traceutil/trace.go:171","msg":"trace[785151918] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1883; }","duration":"631.378907ms","start":"2026-05-21T14:51:38.83564Z","end":"2026-05-21T14:51:39.467019Z","steps":["trace[785151918] 'agreement among raft nodes before linearized reading' (duration: 631.330496ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:39.467047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:38.835558Z","time spent":"631.48441ms","remote":"127.0.0.1:51426","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-05-21T14:51:39.466935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.424291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c37b0bf9-fd8b-47bb-a147-7ff99f9ec765\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-05-21T14:51:39.467299Z","caller":"traceutil/trace.go:171","msg":"trace[626485954] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c37b0bf9-fd8b-47bb-a147-7ff99f9ec765; range_end:; response_count:1; response_revision:1883; }","duration":"244.833463ms","start":"2026-05-21T14:51:39.222453Z","end":"2026-05-21T14:51:39.467286Z","steps":["trace[626485954] 'agreement among raft nodes before linearized reading' (duration: 244.38732ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:39.469888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.046831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-21T14:51:39.469954Z","caller":"traceutil/trace.go:171","msg":"trace[1230697793] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1883; }","duration":"692.293078ms","start":"2026-05-21T14:51:38.777645Z","end":"2026-05-21T14:51:39.469938Z","steps":["trace[1230697793] 'agreement among raft nodes before linearized reading' (duration: 689.331811ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:39.469993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:38.777633Z","time spent":"692.350119ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-21T14:51:50.435353Z","caller":"traceutil/trace.go:171","msg":"trace[1882544791] linearizableReadLoop","detail":"{readStateIndex:2062; appliedIndex:2060; }","duration":"158.167923ms","start":"2026-05-21T14:51:50.277134Z","end":"2026-05-21T14:51:50.435302Z","steps":["trace[1882544791] 'read index received' (duration: 51.266538ms)","trace[1882544791] 'applied index is now lower than readState.Index' (duration: 106.900315ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T14:51:50.435555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.40319ms","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-05-21T14:51:50.435539Z","caller":"traceutil/trace.go:171","msg":"trace[2099822508] transaction","detail":"{read_only:false; response_revision:1981; number_of_response:1; }","duration":"174.980254ms","start":"2026-05-21T14:51:50.260531Z","end":"2026-05-21T14:51:50.435512Z","steps":["trace[2099822508] 'process raft request' (duration: 172.706356ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:51:50.435601Z","caller":"traceutil/trace.go:171","msg":"trace[500858995] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1981; }","duration":"158.497563ms","start":"2026-05-21T14:51:50.277093Z","end":"2026-05-21T14:51:50.435591Z","steps":["trace[500858995] 'agreement among raft nodes before linearized reading' (duration: 158.335318ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:54.973497Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831962830402330,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-21T14:51:55.069506Z","caller":"traceutil/trace.go:171","msg":"trace[1679068361] transaction","detail":"{read_only:false; response_revision:2011; number_of_response:1; }","duration":"730.218904ms","start":"2026-05-21T14:51:54.339257Z","end":"2026-05-21T14:51:55.069476Z","steps":["trace[1679068361] 'process raft request' (duration: 730.038018ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:55.069889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:54.339222Z","time spent":"730.394809ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T14:51:55.261113Z","caller":"traceutil/trace.go:171","msg":"trace[750546082] linearizableReadLoop","detail":"{readStateIndex:2096; appliedIndex:2092; }","duration":"788.657504ms","start":"2026-05-21T14:51:54.472434Z","end":"2026-05-21T14:51:55.261092Z","steps":["trace[750546082] 'read index received' (duration: 596.816307ms)","trace[750546082] 'applied index is now lower than readState.Index' (duration: 191.840187ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T14:51:55.261197Z","caller":"traceutil/trace.go:171","msg":"trace[173108682] transaction","detail":"{read_only:false; response_revision:2013; number_of_response:1; }","duration":"783.648974ms","start":"2026-05-21T14:51:54.477505Z","end":"2026-05-21T14:51:55.261154Z","steps":["trace[173108682] 'process raft request' (duration: 783.50866ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:55.261364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"788.911191ms","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-05-21T14:51:55.261426Z","caller":"traceutil/trace.go:171","msg":"trace[2094805979] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2014; }","duration":"789.019625ms","start":"2026-05-21T14:51:54.472395Z","end":"2026-05-21T14:51:55.261415Z","steps":["trace[2094805979] 'agreement among raft nodes before linearized reading' (duration: 788.816299ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:55.261389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:54.477486Z","time spent":"783.809349ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T14:51:55.261424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.529978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-21T14:51:55.261475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:54.472376Z","time spent":"789.085907ms","remote":"127.0.0.1:51694","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-05-21T14:51:55.261505Z","caller":"traceutil/trace.go:171","msg":"trace[99142507] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:2014; }","duration":"561.665112ms","start":"2026-05-21T14:51:54.699823Z","end":"2026-05-21T14:51:55.261488Z","steps":["trace[99142507] 'agreement among raft nodes before linearized reading' (duration: 561.505047ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:55.261598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:54.699807Z","time spent":"561.776336ms","remote":"127.0.0.1:51604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":15,"response size":30,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"info","ts":"2026-05-21T14:51:55.261902Z","caller":"traceutil/trace.go:171","msg":"trace[525114849] transaction","detail":"{read_only:false; response_revision:2014; number_of_response:1; }","duration":"322.591207ms","start":"2026-05-21T14:51:54.938608Z","end":"2026-05-21T14:51:55.261199Z","steps":["trace[525114849] 'process raft request' (duration: 322.446233ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:55.261999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.095062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-21T14:51:55.262064Z","caller":"traceutil/trace.go:171","msg":"trace[1422592808] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2014; }","duration":"631.197485ms","start":"2026-05-21T14:51:54.630854Z","end":"2026-05-21T14:51:55.262051Z","steps":["trace[1422592808] 'agreement among raft nodes before linearized reading' (duration: 630.37949ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:55.262102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:54.630835Z","time spent":"631.258967ms","remote":"127.0.0.1:40742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-05-21T14:51:55.261156Z","caller":"traceutil/trace.go:171","msg":"trace[332171337] transaction","detail":"{read_only:false; response_revision:2012; number_of_response:1; }","duration":"815.362994ms","start":"2026-05-21T14:51:54.445765Z","end":"2026-05-21T14:51:55.261128Z","steps":["trace[332171337] 'process raft request' (duration: 815.098926ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:51:55.263235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:54.445739Z","time spent":"817.421275ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T14:51:55.26366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:51:54.93858Z","time spent":"323.36439ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T14:52:17.781744Z","caller":"traceutil/trace.go:171","msg":"trace[1740552803] linearizableReadLoop","detail":"{readStateIndex:2225; appliedIndex:2224; }","duration":"404.309086ms","start":"2026-05-21T14:52:17.377412Z","end":"2026-05-21T14:52:17.781721Z","steps":["trace[1740552803] 'read index received' (duration: 404.09617ms)","trace[1740552803] 'applied index is now lower than readState.Index' (duration: 211.826µs)"],"step_count":2} {"level":"info","ts":"2026-05-21T14:52:17.78187Z","caller":"traceutil/trace.go:171","msg":"trace[767539137] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"414.895701ms","start":"2026-05-21T14:52:17.366962Z","end":"2026-05-21T14:52:17.781858Z","steps":["trace[767539137] 'process raft request' (duration: 414.612083ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:52:17.781978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:52:17.366943Z","time spent":"414.957934ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T14:52:17.782123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.580469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-21T14:52:17.782256Z","caller":"traceutil/trace.go:171","msg":"trace[205036727] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2139; }","duration":"370.706163ms","start":"2026-05-21T14:52:17.411486Z","end":"2026-05-21T14:52:17.782192Z","steps":["trace[205036727] 'agreement among raft nodes before linearized reading' (duration: 370.471026ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:52:17.782319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:52:17.411473Z","time spent":"370.832517ms","remote":"127.0.0.1:40742","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-05-21T14:52:17.78257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.155862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T14:52:17.782625Z","caller":"traceutil/trace.go:171","msg":"trace[2089640873] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:2139; }","duration":"405.235685ms","start":"2026-05-21T14:52:17.377374Z","end":"2026-05-21T14:52:17.78261Z","steps":["trace[2089640873] 'agreement among raft nodes before linearized reading' (duration: 405.154383ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:52:17.782846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:52:17.377363Z","time spent":"405.465712ms","remote":"127.0.0.1:46560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"info","ts":"2026-05-21T14:52:17.955014Z","caller":"traceutil/trace.go:171","msg":"trace[1826267655] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"166.034414ms","start":"2026-05-21T14:52:17.788939Z","end":"2026-05-21T14:52:17.954974Z","steps":["trace[1826267655] 'process raft request' (duration: 103.652876ms)","trace[1826267655] 'compare' (duration: 62.153951ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T14:52:17.955081Z","caller":"traceutil/trace.go:171","msg":"trace[1398910762] linearizableReadLoop","detail":"{readStateIndex:2227; appliedIndex:2226; }","duration":"146.560545ms","start":"2026-05-21T14:52:17.80851Z","end":"2026-05-21T14:52:17.955071Z","steps":["trace[1398910762] 'read index received' (duration: 84.093625ms)","trace[1398910762] 'applied index is now lower than readState.Index' (duration: 62.46594ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T14:52:17.955014Z","caller":"traceutil/trace.go:171","msg":"trace[1541061002] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"142.109848ms","start":"2026-05-21T14:52:17.812874Z","end":"2026-05-21T14:52:17.954984Z","steps":["trace[1541061002] 'process raft request' (duration: 142.045846ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:52:17.95549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.215188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-21T14:52:17.955533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.762492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-21T14:52:17.95554Z","caller":"traceutil/trace.go:171","msg":"trace[1979035243] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2142; }","duration":"164.30264ms","start":"2026-05-21T14:52:17.791224Z","end":"2026-05-21T14:52:17.955526Z","steps":["trace[1979035243] 'agreement among raft nodes before linearized reading' (duration: 163.897018ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:52:17.955659Z","caller":"traceutil/trace.go:171","msg":"trace[1987357268] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2142; }","duration":"162.913287ms","start":"2026-05-21T14:52:17.792724Z","end":"2026-05-21T14:52:17.955637Z","steps":["trace[1987357268] 'agreement among raft nodes before linearized reading' (duration: 162.529096ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:52:17.955719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.969639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-21T14:52:17.95576Z","caller":"traceutil/trace.go:171","msg":"trace[806879324] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2142; }","duration":"163.023331ms","start":"2026-05-21T14:52:17.792725Z","end":"2026-05-21T14:52:17.955748Z","steps":["trace[806879324] 'agreement among raft nodes before linearized reading' (duration: 162.865306ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:52:19.178497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.864937ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-05-21T14:52:20.25471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.032166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-21T14:52:20.25479Z","caller":"traceutil/trace.go:171","msg":"trace[703202998] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:2150; }","duration":"353.163801ms","start":"2026-05-21T14:52:19.901608Z","end":"2026-05-21T14:52:20.254772Z","steps":["trace[703202998] 'count revisions from in-memory index tree' (duration: 352.903282ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:52:20.254845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:52:19.901591Z","time spent":"353.242894ms","remote":"127.0.0.1:51588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":30,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-05-21T14:52:20.254807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.110128ms","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-05-21T14:52:20.25508Z","caller":"traceutil/trace.go:171","msg":"trace[381443328] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2150; }","duration":"466.426717ms","start":"2026-05-21T14:52:19.788632Z","end":"2026-05-21T14:52:20.255059Z","steps":["trace[381443328] 'range keys from in-memory index tree' (duration: 465.883401ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:52:20.255214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:52:19.788611Z","time spent":"466.50429ms","remote":"127.0.0.1:51694","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-05-21T14:52:20.2552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.260535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-21T14:52:20.255336Z","caller":"traceutil/trace.go:171","msg":"trace[1821032988] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2150; }","duration":"456.380038ms","start":"2026-05-21T14:52:19.798877Z","end":"2026-05-21T14:52:20.255257Z","steps":["trace[1821032988] 'range keys from in-memory index tree' (duration: 456.094379ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:52:20.255391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:52:19.798787Z","time spent":"456.591564ms","remote":"127.0.0.1:40742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-05-21T14:52:20.280574Z","caller":"traceutil/trace.go:171","msg":"trace[385144223] linearizableReadLoop","detail":"{readStateIndex:2238; appliedIndex:2237; }","duration":"319.420072ms","start":"2026-05-21T14:52:19.961132Z","end":"2026-05-21T14:52:20.280552Z","steps":["trace[385144223] 'read index received' (duration: 319.36171ms)","trace[385144223] 'applied index is now lower than readState.Index' (duration: 57.072µs)"],"step_count":2} {"level":"info","ts":"2026-05-21T14:52:20.280699Z","caller":"traceutil/trace.go:171","msg":"trace[1785670976] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"321.059153ms","start":"2026-05-21T14:52:19.959559Z","end":"2026-05-21T14:52:20.280618Z","steps":["trace[1785670976] 'process raft request' (duration: 320.820496ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:52:20.280972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:52:19.95953Z","time spent":"321.31912ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T14:52:20.280797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.663068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-21T14:52:20.281039Z","caller":"traceutil/trace.go:171","msg":"trace[517262015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2151; }","duration":"319.966888ms","start":"2026-05-21T14:52:19.961056Z","end":"2026-05-21T14:52:20.281023Z","steps":["trace[517262015] 'agreement among raft nodes before linearized reading' (duration: 319.610107ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:52:20.281091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:52:19.961038Z","time spent":"320.040721ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-21T14:52:20.957398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.976524ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T14:52:20.958063Z","caller":"traceutil/trace.go:171","msg":"trace[567219982] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"672.218295ms","start":"2026-05-21T14:52:20.285823Z","end":"2026-05-21T14:52:20.958041Z","steps":["trace[567219982] 'process raft request' (duration: 672.148273ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:52:20.958125Z","caller":"traceutil/trace.go:171","msg":"trace[1152518239] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"991.538443ms","start":"2026-05-21T14:52:19.966569Z","end":"2026-05-21T14:52:20.958108Z","steps":["trace[1152518239] 'process raft request' (duration: 493.730263ms)","trace[1152518239] 'compare' (duration: 496.537821ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T14:52:20.958124Z","caller":"traceutil/trace.go:171","msg":"trace[679633425] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"697.063271ms","start":"2026-05-21T14:52:20.26103Z","end":"2026-05-21T14:52:20.958093Z","steps":["trace[679633425] 'process raft request' (duration: 696.823074ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:52:20.958174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:52:20.285782Z","time spent":"672.335549ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T14:52:20.958247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:52:19.966553Z","time spent":"991.627476ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T14:52:20.958233Z","caller":"traceutil/trace.go:171","msg":"trace[1303993000] linearizableReadLoop","detail":"{readStateIndex:2240; appliedIndex:2238; }","duration":"677.55955ms","start":"2026-05-21T14:52:20.28064Z","end":"2026-05-21T14:52:20.958199Z","steps":["trace[1303993000] 'read index received' (duration: 179.76847ms)","trace[1303993000] 'applied index is now lower than readState.Index' (duration: 497.78908ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T14:52:20.958257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:52:20.261007Z","time spent":"697.178984ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T14:52:20.958419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"970.098145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-21T14:52:20.958442Z","caller":"traceutil/trace.go:171","msg":"trace[223607041] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2154; }","duration":"970.140865ms","start":"2026-05-21T14:52:19.988294Z","end":"2026-05-21T14:52:20.958435Z","steps":["trace[223607041] 'agreement among raft nodes before linearized reading' (duration: 970.038962ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:52:20.958468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:52:19.988284Z","time spent":"970.179887ms","remote":"127.0.0.1:51694","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-05-21T14:52:20.958543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"936.734067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-21T14:52:20.958694Z","caller":"traceutil/trace.go:171","msg":"trace[1068272369] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2154; }","duration":"936.946703ms","start":"2026-05-21T14:52:20.021722Z","end":"2026-05-21T14:52:20.958668Z","steps":["trace[1068272369] 'agreement among raft nodes before linearized reading' (duration: 936.4936ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:52:20.958715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.081863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-21T14:52:20.958753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:52:20.021703Z","time spent":"937.038176ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-21T14:52:20.958784Z","caller":"traceutil/trace.go:171","msg":"trace[997203089] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2154; }","duration":"122.196126ms","start":"2026-05-21T14:52:20.836569Z","end":"2026-05-21T14:52:20.958765Z","steps":["trace[997203089] 'agreement among raft nodes before linearized reading' (duration: 122.029791ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:52:20.958791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.642165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12383"} {"level":"info","ts":"2026-05-21T14:52:20.958906Z","caller":"traceutil/trace.go:171","msg":"trace[1313308136] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2154; }","duration":"582.790209ms","start":"2026-05-21T14:52:20.376098Z","end":"2026-05-21T14:52:20.958888Z","steps":["trace[1313308136] 'agreement among raft nodes before linearized reading' (duration: 582.458269ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:52:20.958962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:52:20.37608Z","time spent":"582.866492ms","remote":"127.0.0.1:51608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12406,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-05-21T14:52:20.95917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"969.249568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-21T14:52:20.959303Z","caller":"traceutil/trace.go:171","msg":"trace[1236258862] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2154; }","duration":"970.096773ms","start":"2026-05-21T14:52:19.989188Z","end":"2026-05-21T14:52:20.959285Z","steps":["trace[1236258862] 'agreement among raft nodes before linearized reading' (duration: 969.050031ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:52:20.959435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:52:19.989169Z","time spent":"970.213827ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-21T14:53:03.24183Z","caller":"traceutil/trace.go:171","msg":"trace[1169975177] linearizableReadLoop","detail":"{readStateIndex:2586; appliedIndex:2585; }","duration":"308.463429ms","start":"2026-05-21T14:53:02.933343Z","end":"2026-05-21T14:53:03.241807Z","steps":["trace[1169975177] 'read index received' (duration: 308.423658ms)","trace[1169975177] 'applied index is now lower than readState.Index' (duration: 39.161µs)"],"step_count":2} {"level":"info","ts":"2026-05-21T14:53:03.241877Z","caller":"traceutil/trace.go:171","msg":"trace[1893825668] transaction","detail":"{read_only:false; response_revision:2489; number_of_response:1; }","duration":"388.268583ms","start":"2026-05-21T14:53:02.853589Z","end":"2026-05-21T14:53:03.241858Z","steps":["trace[1893825668] 'process raft request' (duration: 388.097057ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:53:03.242058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:53:02.853564Z","time spent":"388.421927ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T14:53:03.243153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.813522ms","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-05-21T14:53:03.243264Z","caller":"traceutil/trace.go:171","msg":"trace[476650721] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2489; }","duration":"309.898595ms","start":"2026-05-21T14:53:02.933284Z","end":"2026-05-21T14:53:03.243182Z","steps":["trace[476650721] 'agreement among raft nodes before linearized reading' (duration: 308.617124ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:53:03.24339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:53:02.933262Z","time spent":"310.06585ms","remote":"127.0.0.1:51622","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-05-21T14:53:03.243439Z","caller":"traceutil/trace.go:171","msg":"trace[936598205] transaction","detail":"{read_only:false; response_revision:2490; number_of_response:1; }","duration":"140.734822ms","start":"2026-05-21T14:53:03.102677Z","end":"2026-05-21T14:53:03.243412Z","steps":["trace[936598205] 'process raft request' (duration: 140.630279ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:53:37.261164Z","caller":"traceutil/trace.go:171","msg":"trace[1259062223] linearizableReadLoop","detail":"{readStateIndex:2782; appliedIndex:2781; }","duration":"255.624288ms","start":"2026-05-21T14:53:37.005511Z","end":"2026-05-21T14:53:37.261136Z","steps":["trace[1259062223] 'read index received' (duration: 255.382531ms)","trace[1259062223] 'applied index is now lower than readState.Index' (duration: 240.517µs)"],"step_count":2} {"level":"info","ts":"2026-05-21T14:53:37.261225Z","caller":"traceutil/trace.go:171","msg":"trace[599057384] transaction","detail":"{read_only:false; response_revision:2677; number_of_response:1; }","duration":"279.410239ms","start":"2026-05-21T14:53:36.981794Z","end":"2026-05-21T14:53:37.261204Z","steps":["trace[599057384] 'process raft request' (duration: 279.180682ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:53:37.261643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.050281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T14:53:37.261709Z","caller":"traceutil/trace.go:171","msg":"trace[888089845] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2677; }","duration":"256.193386ms","start":"2026-05-21T14:53:37.005497Z","end":"2026-05-21T14:53:37.26169Z","steps":["trace[888089845] 'agreement among raft nodes before linearized reading' (duration: 255.750802ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:57:12.885984Z","caller":"traceutil/trace.go:171","msg":"trace[163070029] linearizableReadLoop","detail":"{readStateIndex:4554; appliedIndex:4553; }","duration":"157.243381ms","start":"2026-05-21T14:57:12.728709Z","end":"2026-05-21T14:57:12.885953Z","steps":["trace[163070029] 'read index received' (duration: 138.147195ms)","trace[163070029] 'applied index is now lower than readState.Index' (duration: 19.095506ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T14:57:12.886206Z","caller":"traceutil/trace.go:171","msg":"trace[267979147] transaction","detail":"{read_only:false; response_revision:4377; number_of_response:1; }","duration":"174.559273ms","start":"2026-05-21T14:57:12.711637Z","end":"2026-05-21T14:57:12.886196Z","steps":["trace[267979147] 'process raft request' (duration: 155.310233ms)","trace[267979147] 'compare' (duration: 18.932683ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T14:57:12.887821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.099117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-21T14:57:12.887946Z","caller":"traceutil/trace.go:171","msg":"trace[56138347] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4377; }","duration":"159.258671ms","start":"2026-05-21T14:57:12.728678Z","end":"2026-05-21T14:57:12.887936Z","steps":["trace[56138347] 'agreement among raft nodes before linearized reading' (duration: 159.069517ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:57:12.888059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.113753ms","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-05-21T14:57:12.888792Z","caller":"traceutil/trace.go:171","msg":"trace[601196476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4377; }","duration":"156.300098ms","start":"2026-05-21T14:57:12.732472Z","end":"2026-05-21T14:57:12.888772Z","steps":["trace[601196476] 'agreement among raft nodes before linearized reading' (duration: 153.951069ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:57:18.037007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.960572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-05-21T14:57:18.037089Z","caller":"traceutil/trace.go:171","msg":"trace[147288111] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4543; }","duration":"114.108296ms","start":"2026-05-21T14:57:17.922964Z","end":"2026-05-21T14:57:18.037073Z","steps":["trace[147288111] 'agreement among raft nodes before linearized reading' (duration: 113.885911ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:57:18.037259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.904892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-qmkm4-tls\" ","response":"range_response_count:1 size:2301"} {"level":"info","ts":"2026-05-21T14:57:18.037373Z","caller":"traceutil/trace.go:171","msg":"trace[391484095] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-qmkm4-tls; range_end:; response_count:1; response_revision:4543; }","duration":"112.054525ms","start":"2026-05-21T14:57:17.925302Z","end":"2026-05-21T14:57:18.037356Z","steps":["trace[391484095] 'agreement among raft nodes before linearized reading' (duration: 111.83459ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:57:18.329295Z","caller":"traceutil/trace.go:171","msg":"trace[27859198] transaction","detail":"{read_only:false; response_revision:4551; number_of_response:1; }","duration":"109.232847ms","start":"2026-05-21T14:57:18.220041Z","end":"2026-05-21T14:57:18.329273Z","steps":["trace[27859198] 'process raft request' (duration: 109.068773ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:57:18.329306Z","caller":"traceutil/trace.go:171","msg":"trace[34157614] linearizableReadLoop","detail":"{readStateIndex:4735; appliedIndex:4735; }","duration":"106.657582ms","start":"2026-05-21T14:57:18.222618Z","end":"2026-05-21T14:57:18.329275Z","steps":["trace[34157614] 'read index received' (duration: 106.645991ms)","trace[34157614] 'applied index is now lower than readState.Index' (duration: 9.761µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T14:57:18.329694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.053641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-21T14:57:18.329726Z","caller":"traceutil/trace.go:171","msg":"trace[121929579] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4551; }","duration":"107.133654ms","start":"2026-05-21T14:57:18.222584Z","end":"2026-05-21T14:57:18.329718Z","steps":["trace[121929579] 'agreement among raft nodes before linearized reading' (duration: 106.848947ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:57:18.54863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.299161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-05-21T14:57:18.548718Z","caller":"traceutil/trace.go:171","msg":"trace[145585948] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4552; }","duration":"127.415915ms","start":"2026-05-21T14:57:18.421283Z","end":"2026-05-21T14:57:18.548699Z","steps":["trace[145585948] 'range keys from in-memory index tree' (duration: 125.577497ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:57:24.902811Z","caller":"traceutil/trace.go:171","msg":"trace[2098824390] linearizableReadLoop","detail":"{readStateIndex:4852; appliedIndex:4851; }","duration":"172.652857ms","start":"2026-05-21T14:57:24.730128Z","end":"2026-05-21T14:57:24.902781Z","steps":["trace[2098824390] 'read index received' (duration: 167.894566ms)","trace[2098824390] 'applied index is now lower than readState.Index' (duration: 4.756901ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T14:57:24.902831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.106373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206973"} {"level":"warn","ts":"2026-05-21T14:57:24.903395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.17917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-21T14:57:24.903376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.18429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-21T14:57:24.903461Z","caller":"traceutil/trace.go:171","msg":"trace[1479107888] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4666; }","duration":"173.360935ms","start":"2026-05-21T14:57:24.730085Z","end":"2026-05-21T14:57:24.903446Z","steps":["trace[1479107888] 'agreement among raft nodes before linearized reading' (duration: 172.896093ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:57:24.903451Z","caller":"traceutil/trace.go:171","msg":"trace[1922586179] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4666; }","duration":"173.273553ms","start":"2026-05-21T14:57:24.730164Z","end":"2026-05-21T14:57:24.903437Z","steps":["trace[1922586179] 'agreement among raft nodes before linearized reading' (duration: 173.146519ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:57:24.903849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.135152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-05-21T14:57:24.903905Z","caller":"traceutil/trace.go:171","msg":"trace[1402987547] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4666; }","duration":"108.220524ms","start":"2026-05-21T14:57:24.795671Z","end":"2026-05-21T14:57:24.903892Z","steps":["trace[1402987547] 'agreement among raft nodes before linearized reading' (duration: 108.025558ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:57:24.903499Z","caller":"traceutil/trace.go:171","msg":"trace[2077304939] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4665; }","duration":"340.763629ms","start":"2026-05-21T14:57:24.562661Z","end":"2026-05-21T14:57:24.903424Z","steps":["trace[2077304939] 'range keys from in-memory index tree' (duration: 339.354033ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:57:24.904073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.998346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-21T14:57:24.90282Z","caller":"traceutil/trace.go:171","msg":"trace[252119093] transaction","detail":"{read_only:false; response_revision:4666; number_of_response:1; }","duration":"317.362946ms","start":"2026-05-21T14:57:24.585423Z","end":"2026-05-21T14:57:24.902786Z","steps":["trace[252119093] 'process raft request' (duration: 312.617966ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:57:24.904259Z","caller":"traceutil/trace.go:171","msg":"trace[567458236] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:4666; }","duration":"115.226692ms","start":"2026-05-21T14:57:24.789019Z","end":"2026-05-21T14:57:24.904246Z","steps":["trace[567458236] 'agreement among raft nodes before linearized reading' (duration: 114.835942ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:57:24.904357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:57:24.585403Z","time spent":"318.904655ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T14:57:24.904327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:57:24.562644Z","time spent":"341.5801ms","remote":"127.0.0.1:51536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2206996,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"warn","ts":"2026-05-21T14:57:24.911063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.532904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-fcfb6b54f-j7zhx.18b19c89e0e9401d\" ","response":"range_response_count:1 size:893"} {"level":"info","ts":"2026-05-21T14:57:24.911112Z","caller":"traceutil/trace.go:171","msg":"trace[867906961] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-fcfb6b54f-j7zhx.18b19c89e0e9401d; range_end:; response_count:1; response_revision:4666; }","duration":"114.596515ms","start":"2026-05-21T14:57:24.796503Z","end":"2026-05-21T14:57:24.9111Z","steps":["trace[867906961] 'agreement among raft nodes before linearized reading' (duration: 107.397103ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:57:25.058215Z","caller":"traceutil/trace.go:171","msg":"trace[776179592] transaction","detail":"{read_only:false; response_revision:4667; number_of_response:1; }","duration":"147.620614ms","start":"2026-05-21T14:57:24.910576Z","end":"2026-05-21T14:57:25.058197Z","steps":["trace[776179592] 'process raft request' (duration: 122.721872ms)","trace[776179592] 'compare' (duration: 24.824571ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T14:57:25.067054Z","caller":"traceutil/trace.go:171","msg":"trace[595910940] transaction","detail":"{read_only:false; response_revision:4669; number_of_response:1; }","duration":"154.166781ms","start":"2026-05-21T14:57:24.912869Z","end":"2026-05-21T14:57:25.067036Z","steps":["trace[595910940] 'process raft request' (duration: 154.081359ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:57:25.067055Z","caller":"traceutil/trace.go:171","msg":"trace[1808204283] transaction","detail":"{read_only:false; response_revision:4668; number_of_response:1; }","duration":"155.549656ms","start":"2026-05-21T14:57:24.911486Z","end":"2026-05-21T14:57:25.067035Z","steps":["trace[1808204283] 'process raft request' (duration: 155.351461ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:57:25.067187Z","caller":"traceutil/trace.go:171","msg":"trace[124223595] linearizableReadLoop","detail":"{readStateIndex:4856; appliedIndex:4852; }","duration":"131.985678ms","start":"2026-05-21T14:57:24.935193Z","end":"2026-05-21T14:57:25.067179Z","steps":["trace[124223595] 'read index received' (duration: 98.15806ms)","trace[124223595] 'applied index is now lower than readState.Index' (duration: 33.826628ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T14:57:25.067353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.145312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-05-21T14:57:25.067387Z","caller":"traceutil/trace.go:171","msg":"trace[780356937] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4670; }","duration":"132.226364ms","start":"2026-05-21T14:57:24.935153Z","end":"2026-05-21T14:57:25.067379Z","steps":["trace[780356937] 'agreement among raft nodes before linearized reading' (duration: 132.04903ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:57:25.067497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.627566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-21T14:57:25.067552Z","caller":"traceutil/trace.go:171","msg":"trace[1688659771] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4670; }","duration":"123.709608ms","start":"2026-05-21T14:57:24.94383Z","end":"2026-05-21T14:57:25.06754Z","steps":["trace[1688659771] 'agreement among raft nodes before linearized reading' (duration: 123.555965ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:57:25.06756Z","caller":"traceutil/trace.go:171","msg":"trace[1038031801] transaction","detail":"{read_only:false; response_revision:4670; number_of_response:1; }","duration":"153.423712ms","start":"2026-05-21T14:57:24.914128Z","end":"2026-05-21T14:57:25.067552Z","steps":["trace[1038031801] 'process raft request' (duration: 152.864868ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:57:25.067684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.928099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-21T14:57:25.067715Z","caller":"traceutil/trace.go:171","msg":"trace[1425972507] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4670; }","duration":"122.97069ms","start":"2026-05-21T14:57:24.944737Z","end":"2026-05-21T14:57:25.067708Z","steps":["trace[1425972507] 'agreement among raft nodes before linearized reading' (duration: 122.895088ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:57:25.191621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.340898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-05-21T14:57:25.191678Z","caller":"traceutil/trace.go:171","msg":"trace[256945664] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4678; }","duration":"100.417229ms","start":"2026-05-21T14:57:25.091248Z","end":"2026-05-21T14:57:25.191666Z","steps":["trace[256945664] 'agreement among raft nodes before linearized reading' (duration: 100.252515ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:57:25.843957Z","caller":"traceutil/trace.go:171","msg":"trace[1077458093] transaction","detail":"{read_only:false; response_revision:4680; number_of_response:1; }","duration":"605.952763ms","start":"2026-05-21T14:57:25.237981Z","end":"2026-05-21T14:57:25.843934Z","steps":["trace[1077458093] 'process raft request' (duration: 546.040412ms)","trace[1077458093] 'compare' (duration: 59.655604ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T14:57:25.844106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:57:25.23797Z","time spent":"606.053665ms","remote":"127.0.0.1:57514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7495,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T14:57:25.859403Z","caller":"traceutil/trace.go:171","msg":"trace[660618466] transaction","detail":"{read_only:false; response_revision:4681; number_of_response:1; }","duration":"473.661454ms","start":"2026-05-21T14:57:25.385721Z","end":"2026-05-21T14:57:25.859383Z","steps":["trace[660618466] 'process raft request' (duration: 473.518461ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:57:25.859521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:57:25.385695Z","time spent":"473.765267ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T14:57:25.859596Z","caller":"traceutil/trace.go:171","msg":"trace[488892708] linearizableReadLoop","detail":"{readStateIndex:4868; appliedIndex:4865; }","duration":"373.944814ms","start":"2026-05-21T14:57:25.485623Z","end":"2026-05-21T14:57:25.859568Z","steps":["trace[488892708] 'read index received' (duration: 298.354435ms)","trace[488892708] 'applied index is now lower than readState.Index' (duration: 75.588559ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T14:57:25.85967Z","caller":"traceutil/trace.go:171","msg":"trace[231896926] transaction","detail":"{read_only:false; response_revision:4682; number_of_response:1; }","duration":"408.221424ms","start":"2026-05-21T14:57:25.451428Z","end":"2026-05-21T14:57:25.85965Z","steps":["trace[231896926] 'process raft request' (duration: 407.931047ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:57:25.859775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:57:25.451404Z","time spent":"408.317306ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T14:57:25.859795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.163489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-21T14:57:25.859832Z","caller":"traceutil/trace.go:171","msg":"trace[725154776] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:4682; }","duration":"374.247781ms","start":"2026-05-21T14:57:25.485571Z","end":"2026-05-21T14:57:25.859819Z","steps":["trace[725154776] 'agreement among raft nodes before linearized reading' (duration: 374.164419ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:57:25.85988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:57:25.485551Z","time spent":"374.305812ms","remote":"127.0.0.1:51942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":4,"response size":30,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-05-21T14:57:27.844092Z","caller":"traceutil/trace.go:171","msg":"trace[480437651] transaction","detail":"{read_only:false; response_revision:4706; number_of_response:1; }","duration":"262.991814ms","start":"2026-05-21T14:57:27.581077Z","end":"2026-05-21T14:57:27.844069Z","steps":["trace[480437651] 'process raft request' (duration: 262.761068ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:57:30.611913Z","caller":"traceutil/trace.go:171","msg":"trace[2122254045] transaction","detail":"{read_only:false; response_revision:4747; number_of_response:1; }","duration":"100.869847ms","start":"2026-05-21T14:57:30.51102Z","end":"2026-05-21T14:57:30.61189Z","steps":["trace[2122254045] 'process raft request' (duration: 100.815015ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:57:30.611973Z","caller":"traceutil/trace.go:171","msg":"trace[105663142] transaction","detail":"{read_only:false; response_revision:4746; number_of_response:1; }","duration":"122.17098ms","start":"2026-05-21T14:57:30.489754Z","end":"2026-05-21T14:57:30.611925Z","steps":["trace[105663142] 'process raft request' (duration: 96.808253ms)","trace[105663142] 'compare' (duration: 25.011099ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T14:57:33.880175Z","caller":"traceutil/trace.go:171","msg":"trace[1224681357] linearizableReadLoop","detail":"{readStateIndex:4997; appliedIndex:4996; }","duration":"199.200658ms","start":"2026-05-21T14:57:33.680948Z","end":"2026-05-21T14:57:33.880149Z","steps":["trace[1224681357] 'read index received' (duration: 198.992673ms)","trace[1224681357] 'applied index is now lower than readState.Index' (duration: 207.025µs)"],"step_count":2} {"level":"info","ts":"2026-05-21T14:57:33.880282Z","caller":"traceutil/trace.go:171","msg":"trace[1426180649] transaction","detail":"{read_only:false; response_revision:4807; number_of_response:1; }","duration":"258.039577ms","start":"2026-05-21T14:57:33.622203Z","end":"2026-05-21T14:57:33.880243Z","steps":["trace[1426180649] 'process raft request' (duration: 257.80108ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:57:33.880398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.439444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.115\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-21T14:57:33.880473Z","caller":"traceutil/trace.go:171","msg":"trace[238840046] range","detail":"{range_begin:/registry/masterleases/199.204.45.115; range_end:; response_count:1; response_revision:4807; }","duration":"199.561337ms","start":"2026-05-21T14:57:33.680894Z","end":"2026-05-21T14:57:33.880456Z","steps":["trace[238840046] 'agreement among raft nodes before linearized reading' (duration: 199.384822ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:57:38.593105Z","caller":"traceutil/trace.go:171","msg":"trace[178902701] linearizableReadLoop","detail":"{readStateIndex:5041; appliedIndex:5040; }","duration":"304.466873ms","start":"2026-05-21T14:57:38.288614Z","end":"2026-05-21T14:57:38.593081Z","steps":["trace[178902701] 'read index received' (duration: 304.32701ms)","trace[178902701] 'applied index is now lower than readState.Index' (duration: 139.013µs)"],"step_count":2} {"level":"info","ts":"2026-05-21T14:57:38.593155Z","caller":"traceutil/trace.go:171","msg":"trace[213123571] transaction","detail":"{read_only:false; response_revision:4850; number_of_response:1; }","duration":"336.626191ms","start":"2026-05-21T14:57:38.256507Z","end":"2026-05-21T14:57:38.593133Z","steps":["trace[213123571] 'process raft request' (duration: 336.418816ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:57:38.593233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.609376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T14:57:38.593269Z","caller":"traceutil/trace.go:171","msg":"trace[598344411] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:4850; }","duration":"304.689049ms","start":"2026-05-21T14:57:38.288568Z","end":"2026-05-21T14:57:38.593257Z","steps":["trace[598344411] 'agreement among raft nodes before linearized reading' (duration: 304.617267ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:57:38.593276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:57:38.25649Z","time spent":"336.712764ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T14:57:38.593307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:57:38.288551Z","time spent":"304.74639ms","remote":"127.0.0.1:40628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true "} {"level":"warn","ts":"2026-05-21T14:57:38.90482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.348951ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T14:57:38.90492Z","caller":"traceutil/trace.go:171","msg":"trace[1293348479] linearizableReadLoop","detail":"{readStateIndex:5042; appliedIndex:5041; }","duration":"311.7367ms","start":"2026-05-21T14:57:38.593168Z","end":"2026-05-21T14:57:38.904904Z","steps":["trace[1293348479] 'read index received' (duration: 81.066571ms)","trace[1293348479] 'applied index is now lower than readState.Index' (duration: 230.668809ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T14:57:38.905001Z","caller":"traceutil/trace.go:171","msg":"trace[470288103] transaction","detail":"{read_only:false; response_revision:4851; number_of_response:1; }","duration":"504.755709ms","start":"2026-05-21T14:57:38.400231Z","end":"2026-05-21T14:57:38.904987Z","steps":["trace[470288103] 'process raft request' (duration: 274.155741ms)","trace[470288103] 'compare' (duration: 230.213618ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T14:57:38.905063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:57:38.400203Z","time spent":"504.829942ms","remote":"127.0.0.1:51694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T14:57:38.905091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.024615ms","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-05-21T14:57:38.905166Z","caller":"traceutil/trace.go:171","msg":"trace[2079004336] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4851; }","duration":"351.149738ms","start":"2026-05-21T14:57:38.554001Z","end":"2026-05-21T14:57:38.905151Z","steps":["trace[2079004336] 'agreement among raft nodes before linearized reading' (duration: 351.028915ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:57:38.905225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:57:38.553981Z","time spent":"351.23312ms","remote":"127.0.0.1:40732","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":"info","ts":"2026-05-21T14:57:39.090299Z","caller":"traceutil/trace.go:171","msg":"trace[409298518] linearizableReadLoop","detail":"{readStateIndex:5044; appliedIndex:5043; }","duration":"129.571435ms","start":"2026-05-21T14:57:38.960704Z","end":"2026-05-21T14:57:39.090276Z","steps":["trace[409298518] 'read index received' (duration: 129.464552ms)","trace[409298518] 'applied index is now lower than readState.Index' (duration: 105.833µs)"],"step_count":2} {"level":"info","ts":"2026-05-21T14:57:39.090771Z","caller":"traceutil/trace.go:171","msg":"trace[1082619698] transaction","detail":"{read_only:false; response_revision:4852; number_of_response:1; }","duration":"141.573154ms","start":"2026-05-21T14:57:38.949181Z","end":"2026-05-21T14:57:39.090754Z","steps":["trace[1082619698] 'process raft request' (duration: 140.936248ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T14:57:39.091266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.52504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13291"} {"level":"info","ts":"2026-05-21T14:57:39.091567Z","caller":"traceutil/trace.go:171","msg":"trace[913450885] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4852; }","duration":"130.708784ms","start":"2026-05-21T14:57:38.960664Z","end":"2026-05-21T14:57:39.091373Z","steps":["trace[913450885] 'agreement among raft nodes before linearized reading' (duration: 130.19488ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:57:39.534952Z","caller":"traceutil/trace.go:171","msg":"trace[1047330783] transaction","detail":"{read_only:false; response_revision:4865; number_of_response:1; }","duration":"185.058659ms","start":"2026-05-21T14:57:39.349869Z","end":"2026-05-21T14:57:39.534927Z","steps":["trace[1047330783] 'process raft request' (duration: 184.973577ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:57:39.534981Z","caller":"traceutil/trace.go:171","msg":"trace[1485697297] transaction","detail":"{read_only:false; response_revision:4864; number_of_response:1; }","duration":"189.37568ms","start":"2026-05-21T14:57:39.345588Z","end":"2026-05-21T14:57:39.534964Z","steps":["trace[1485697297] 'process raft request' (duration: 145.61677ms)","trace[1485697297] 'compare' (duration: 43.494003ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T14:57:40.131028Z","caller":"traceutil/trace.go:171","msg":"trace[954623489] transaction","detail":"{read_only:false; response_revision:4869; number_of_response:1; }","duration":"111.645616ms","start":"2026-05-21T14:57:40.019338Z","end":"2026-05-21T14:57:40.130984Z","steps":["trace[954623489] 'process raft request' (duration: 40.530658ms)","trace[954623489] 'compare' (duration: 70.82503ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T14:57:40.131595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.494162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-cc010770-4357-4571-9a2c-6ceec69da616\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-05-21T14:57:40.131667Z","caller":"traceutil/trace.go:171","msg":"trace[426305139] range","detail":"{range_begin:/registry/persistentvolumes/pvc-cc010770-4357-4571-9a2c-6ceec69da616; range_end:; response_count:1; response_revision:4869; }","duration":"111.608574ms","start":"2026-05-21T14:57:40.020045Z","end":"2026-05-21T14:57:40.131653Z","steps":["trace[426305139] 'agreement among raft nodes before linearized reading' (duration: 111.392558ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:57:40.130906Z","caller":"traceutil/trace.go:171","msg":"trace[1349343985] linearizableReadLoop","detail":"{readStateIndex:5061; appliedIndex:5060; }","duration":"110.791654ms","start":"2026-05-21T14:57:40.020079Z","end":"2026-05-21T14:57:40.13087Z","steps":["trace[1349343985] 'read index received' (duration: 39.82801ms)","trace[1349343985] 'applied index is now lower than readState.Index' (duration: 70.962574ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T14:57:40.1323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.361948ms","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-05-21T14:57:40.132348Z","caller":"traceutil/trace.go:171","msg":"trace[929394033] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4869; }","duration":"104.450531ms","start":"2026-05-21T14:57:40.027884Z","end":"2026-05-21T14:57:40.132334Z","steps":["trace[929394033] 'agreement among raft nodes before linearized reading' (duration: 104.345109ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:57:40.861698Z","caller":"traceutil/trace.go:171","msg":"trace[1062766962] transaction","detail":"{read_only:false; response_revision:4876; number_of_response:1; }","duration":"264.362874ms","start":"2026-05-21T14:57:40.597295Z","end":"2026-05-21T14:57:40.861658Z","steps":["trace[1062766962] 'process raft request' (duration: 263.45279ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:58:19.651301Z","caller":"traceutil/trace.go:171","msg":"trace[690604915] transaction","detail":"{read_only:false; response_revision:5195; number_of_response:1; }","duration":"126.125734ms","start":"2026-05-21T14:58:19.525148Z","end":"2026-05-21T14:58:19.651274Z","steps":["trace[690604915] 'process raft request' (duration: 126.082843ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:58:19.651421Z","caller":"traceutil/trace.go:171","msg":"trace[1619806719] transaction","detail":"{read_only:false; response_revision:5194; number_of_response:1; }","duration":"127.04801ms","start":"2026-05-21T14:58:19.524321Z","end":"2026-05-21T14:58:19.651369Z","steps":["trace[1619806719] 'process raft request' (duration: 126.821494ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T14:59:20.756613Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2907} {"level":"info","ts":"2026-05-21T14:59:20.867519Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2907,"took":"109.443721ms","hash":4114500942,"current-db-size-bytes":53153792,"current-db-size":"53 MB","current-db-size-in-use-bytes":29384704,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-21T14:59:20.867635Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4114500942,"revision":2907,"compact-revision":-1} {"level":"info","ts":"2026-05-21T15:04:20.763522Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5645} {"level":"info","ts":"2026-05-21T15:04:20.8786Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5645,"took":"113.151895ms","hash":2990146418,"current-db-size-bytes":53153792,"current-db-size":"53 MB","current-db-size-in-use-bytes":18309120,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-21T15:04:20.878747Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2990146418,"revision":5645,"compact-revision":2907} {"level":"info","ts":"2026-05-21T15:05:04.492751Z","caller":"traceutil/trace.go:171","msg":"trace[1067152117] linearizableReadLoop","detail":"{readStateIndex:7960; appliedIndex:7959; }","duration":"103.754309ms","start":"2026-05-21T15:05:04.388956Z","end":"2026-05-21T15:05:04.492711Z","steps":["trace[1067152117] 'read index received' (duration: 103.372502ms)","trace[1067152117] 'applied index is now lower than readState.Index' (duration: 380.277µs)"],"step_count":2} {"level":"info","ts":"2026-05-21T15:05:04.493128Z","caller":"traceutil/trace.go:171","msg":"trace[1004887960] transaction","detail":"{read_only:false; response_revision:7666; number_of_response:1; }","duration":"104.69978ms","start":"2026-05-21T15:05:04.388416Z","end":"2026-05-21T15:05:04.493116Z","steps":["trace[1004887960] 'process raft request' (duration: 104.044996ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:05:04.493524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.525055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/auth-system/keycloak\" ","response":"range_response_count:1 size:991"} {"level":"info","ts":"2026-05-21T15:05:04.493635Z","caller":"traceutil/trace.go:171","msg":"trace[1331140998] range","detail":"{range_begin:/registry/services/endpoints/auth-system/keycloak; range_end:; response_count:1; response_revision:7666; }","duration":"104.708109ms","start":"2026-05-21T15:05:04.388902Z","end":"2026-05-21T15:05:04.49361Z","steps":["trace[1331140998] 'agreement among raft nodes before linearized reading' (duration: 104.359492ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:05:33.312525Z","caller":"traceutil/trace.go:171","msg":"trace[988962227] transaction","detail":"{read_only:false; response_revision:7809; number_of_response:1; }","duration":"165.778705ms","start":"2026-05-21T15:05:33.146707Z","end":"2026-05-21T15:05:33.312486Z","steps":["trace[988962227] 'process raft request' (duration: 160.421851ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:05:33.312735Z","caller":"traceutil/trace.go:171","msg":"trace[1112753122] transaction","detail":"{read_only:false; response_revision:7810; number_of_response:1; }","duration":"159.281776ms","start":"2026-05-21T15:05:33.153407Z","end":"2026-05-21T15:05:33.312689Z","steps":["trace[1112753122] 'process raft request' (duration: 158.951638ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:05:59.525534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.770524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/cert-manager/cert-manager-75c4c745bc-vptwm\" ","response":"range_response_count:1 size:4617"} {"level":"info","ts":"2026-05-21T15:05:59.525648Z","caller":"traceutil/trace.go:171","msg":"trace[1976400818] range","detail":"{range_begin:/registry/pods/cert-manager/cert-manager-75c4c745bc-vptwm; range_end:; response_count:1; response_revision:7941; }","duration":"141.942428ms","start":"2026-05-21T15:05:59.383683Z","end":"2026-05-21T15:05:59.525625Z","steps":["trace[1976400818] 'range keys from in-memory index tree' (duration: 141.52007ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:05:59.52591Z","caller":"traceutil/trace.go:171","msg":"trace[2000831470] transaction","detail":"{read_only:false; response_revision:7942; number_of_response:1; }","duration":"105.858888ms","start":"2026-05-21T15:05:59.42002Z","end":"2026-05-21T15:05:59.525879Z","steps":["trace[2000831470] 'compare' (duration: 98.3072ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:05:59.525948Z","caller":"traceutil/trace.go:171","msg":"trace[651113487] transaction","detail":"{read_only:false; response_revision:7943; number_of_response:1; }","duration":"101.975222ms","start":"2026-05-21T15:05:59.42393Z","end":"2026-05-21T15:05:59.525905Z","steps":["trace[651113487] 'process raft request' (duration: 101.759658ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:06:00.400072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.251555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-21T15:06:00.400171Z","caller":"traceutil/trace.go:171","msg":"trace[1321703205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7947; }","duration":"118.427408ms","start":"2026-05-21T15:06:00.281722Z","end":"2026-05-21T15:06:00.40015Z","steps":["trace[1321703205] 'range keys from in-memory index tree' (duration: 117.988019ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:06:00.400584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.406672ms","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-05-21T15:06:00.400844Z","caller":"traceutil/trace.go:171","msg":"trace[1612957078] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:7947; }","duration":"129.636568ms","start":"2026-05-21T15:06:00.271046Z","end":"2026-05-21T15:06:00.400682Z","steps":["trace[1612957078] 'count revisions from in-memory index tree' (duration: 129.29087ms)"],"step_count":1}