{"level":"warn","ts":"2026-03-31T18:26:38.597444Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-31T18:26:38.597559Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.95: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.19.213.95:2380","--initial-cluster=instance=https://199.19.213.95:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.95:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.95: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-03-31T18:26:38.597641Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-31T18:26:38.597652Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.95:2380"]} {"level":"info","ts":"2026-03-31T18:26:38.597673Z","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-03-31T18:26:38.598443Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.95:2379"]} {"level":"info","ts":"2026-03-31T18:26:38.598526Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.95:2380"],"listen-peer-urls":["https://199.19.213.95:2380"],"advertise-client-urls":["https://199.19.213.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.95: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-03-31T18:26:38.602559Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.775021ms"} {"level":"info","ts":"2026-03-31T18:26:38.613144Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"371c7c2e52231793","cluster-id":"c115742627eabb7c"} {"level":"info","ts":"2026-03-31T18:26:38.613282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 switched to configuration voters=()"} {"level":"info","ts":"2026-03-31T18:26:38.613319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 became follower at term 0"} {"level":"info","ts":"2026-03-31T18:26:38.613341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 371c7c2e52231793 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-31T18:26:38.61336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 became follower at term 1"} {"level":"info","ts":"2026-03-31T18:26:38.613412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 switched to configuration voters=(3971185509822306195)"} {"level":"warn","ts":"2026-03-31T18:26:38.618611Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-31T18:26:38.619733Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-31T18:26:38.622039Z","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-03-31T18:26:38.624086Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"371c7c2e52231793","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-31T18:26:38.624355Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"371c7c2e52231793","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-31T18:26:38.62446Z","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-03-31T18:26:38.624594Z","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-03-31T18:26:38.62461Z","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-03-31T18:26:38.625926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 switched to configuration voters=(3971185509822306195)"} {"level":"info","ts":"2026-03-31T18:26:38.626295Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c115742627eabb7c","local-member-id":"371c7c2e52231793","added-peer-id":"371c7c2e52231793","added-peer-peer-urls":["https://199.19.213.95:2380"]} {"level":"info","ts":"2026-03-31T18:26:38.628081Z","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-03-31T18:26:38.628241Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.95:2380"} {"level":"info","ts":"2026-03-31T18:26:38.628295Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.95:2380"} {"level":"info","ts":"2026-03-31T18:26:38.630377Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"371c7c2e52231793","initial-advertise-peer-urls":["https://199.19.213.95:2380"],"listen-peer-urls":["https://199.19.213.95:2380"],"advertise-client-urls":["https://199.19.213.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-31T18:26:38.630432Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-31T18:26:38.914061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 is starting a new election at term 1"} {"level":"info","ts":"2026-03-31T18:26:38.914174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-31T18:26:38.914222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 received MsgPreVoteResp from 371c7c2e52231793 at term 1"} {"level":"info","ts":"2026-03-31T18:26:38.914247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 became candidate at term 2"} {"level":"info","ts":"2026-03-31T18:26:38.914269Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 received MsgVoteResp from 371c7c2e52231793 at term 2"} {"level":"info","ts":"2026-03-31T18:26:38.91429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 became leader at term 2"} {"level":"info","ts":"2026-03-31T18:26:38.914314Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 371c7c2e52231793 elected leader 371c7c2e52231793 at term 2"} {"level":"info","ts":"2026-03-31T18:26:38.915185Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T18:26:38.915853Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"371c7c2e52231793","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.95:2379]}","request-path":"/0/members/371c7c2e52231793/attributes","cluster-id":"c115742627eabb7c","publish-timeout":"7s"} {"level":"info","ts":"2026-03-31T18:26:38.915941Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-31T18:26:38.915965Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-31T18:26:38.916087Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-31T18:26:38.916125Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-31T18:26:38.91637Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c115742627eabb7c","local-member-id":"371c7c2e52231793","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T18:26:38.916545Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T18:26:38.916589Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T18:26:38.920303Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-31T18:26:38.921375Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.95:2379"} {"level":"info","ts":"2026-03-31T18:27:07.214453Z","caller":"traceutil/trace.go:171","msg":"trace[1409322538] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"197.685255ms","start":"2026-03-31T18:27:07.016446Z","end":"2026-03-31T18:27:07.214131Z","steps":["trace[1409322538] 'process raft request' (duration: 189.149536ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:27:07.216083Z","caller":"traceutil/trace.go:171","msg":"trace[1266096788] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"197.200715ms","start":"2026-03-31T18:27:07.018823Z","end":"2026-03-31T18:27:07.216024Z","steps":["trace[1266096788] 'process raft request' (duration: 196.92663ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:27:07.216232Z","caller":"traceutil/trace.go:171","msg":"trace[1773620004] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"196.307189ms","start":"2026-03-31T18:27:07.019872Z","end":"2026-03-31T18:27:07.216179Z","steps":["trace[1773620004] 'process raft request' (duration: 196.029843ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:27:07.216581Z","caller":"traceutil/trace.go:171","msg":"trace[2004257874] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"196.581064ms","start":"2026-03-31T18:27:07.019988Z","end":"2026-03-31T18:27:07.216569Z","steps":["trace[2004257874] 'process raft request' (duration: 195.966382ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:27:07.216644Z","caller":"traceutil/trace.go:171","msg":"trace[273571404] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"143.435024ms","start":"2026-03-31T18:27:07.073169Z","end":"2026-03-31T18:27:07.216604Z","steps":["trace[273571404] 'process raft request' (duration: 142.954114ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:27:08.865877Z","caller":"traceutil/trace.go:171","msg":"trace[241002452] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"104.032049ms","start":"2026-03-31T18:27:08.761813Z","end":"2026-03-31T18:27:08.865845Z","steps":["trace[241002452] 'process raft request' (duration: 103.872196ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:27:08.871454Z","caller":"traceutil/trace.go:171","msg":"trace[673957220] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"105.742611ms","start":"2026-03-31T18:27:08.765664Z","end":"2026-03-31T18:27:08.871407Z","steps":["trace[673957220] 'process raft request' (duration: 105.18973ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:27:08.87162Z","caller":"traceutil/trace.go:171","msg":"trace[326335805] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"105.005756ms","start":"2026-03-31T18:27:08.766578Z","end":"2026-03-31T18:27:08.871584Z","steps":["trace[326335805] 'process raft request' (duration: 104.403385ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:27:10.487271Z","caller":"traceutil/trace.go:171","msg":"trace[1842172901] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"142.154519ms","start":"2026-03-31T18:27:10.345085Z","end":"2026-03-31T18:27:10.48724Z","steps":["trace[1842172901] 'read index received' (duration: 141.67666ms)","trace[1842172901] 'applied index is now lower than readState.Index' (duration: 476.749µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:27:10.487327Z","caller":"traceutil/trace.go:171","msg":"trace[1645164551] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"148.63593ms","start":"2026-03-31T18:27:10.338645Z","end":"2026-03-31T18:27:10.487281Z","steps":["trace[1645164551] 'process raft request' (duration: 148.291934ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:27:10.487593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.483335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570105"} {"level":"info","ts":"2026-03-31T18:27:10.487676Z","caller":"traceutil/trace.go:171","msg":"trace[1154723770] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:584; }","duration":"142.600338ms","start":"2026-03-31T18:27:10.34506Z","end":"2026-03-31T18:27:10.487661Z","steps":["trace[1154723770] 'agreement among raft nodes before linearized reading' (duration: 142.273872ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:27:15.158364Z","caller":"traceutil/trace.go:171","msg":"trace[1540067489] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"100.557495ms","start":"2026-03-31T18:27:15.05776Z","end":"2026-03-31T18:27:15.158318Z","steps":["trace[1540067489] 'process raft request' (duration: 95.412669ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:27:15.611204Z","caller":"traceutil/trace.go:171","msg":"trace[56781212] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"342.581023ms","start":"2026-03-31T18:27:15.268589Z","end":"2026-03-31T18:27:15.61117Z","steps":["trace[56781212] 'read index received' (duration: 342.37847ms)","trace[56781212] 'applied index is now lower than readState.Index' (duration: 201.513µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:27:15.611368Z","caller":"traceutil/trace.go:171","msg":"trace[114847568] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"395.607932ms","start":"2026-03-31T18:27:15.215721Z","end":"2026-03-31T18:27:15.611329Z","steps":["trace[114847568] 'process raft request' (duration: 395.266276ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:27:15.611641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.023803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-03-31T18:27:15.611695Z","caller":"traceutil/trace.go:171","msg":"trace[192260145] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:616; }","duration":"343.154475ms","start":"2026-03-31T18:27:15.268526Z","end":"2026-03-31T18:27:15.611681Z","steps":["trace[192260145] 'agreement among raft nodes before linearized reading' (duration: 342.89645ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:27:15.611737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:27:15.268497Z","time spent":"343.230416ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-31T18:27:15.61167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.326227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:27:15.612036Z","caller":"traceutil/trace.go:171","msg":"trace[911498067] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"124.726964ms","start":"2026-03-31T18:27:15.487221Z","end":"2026-03-31T18:27:15.611948Z","steps":["trace[911498067] 'agreement among raft nodes before linearized reading' (duration: 124.271906ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:27:15.612153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:27:15.21569Z","time spent":"395.776847ms","remote":"127.0.0.1:37278","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T18:27:16.942815Z","caller":"traceutil/trace.go:171","msg":"trace[1006306176] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"116.314678ms","start":"2026-03-31T18:27:16.826475Z","end":"2026-03-31T18:27:16.94279Z","steps":["trace[1006306176] 'process raft request' (duration: 116.248016ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:27:16.942936Z","caller":"traceutil/trace.go:171","msg":"trace[1664705033] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"116.903649ms","start":"2026-03-31T18:27:16.825996Z","end":"2026-03-31T18:27:16.9429Z","steps":["trace[1664705033] 'process raft request' (duration: 116.525872ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:27:16.946006Z","caller":"traceutil/trace.go:171","msg":"trace[1555223688] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"101.98473ms","start":"2026-03-31T18:27:16.843989Z","end":"2026-03-31T18:27:16.945974Z","steps":["trace[1555223688] 'process raft request' (duration: 101.578672ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:27:16.946432Z","caller":"traceutil/trace.go:171","msg":"trace[673594549] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"101.382089ms","start":"2026-03-31T18:27:16.845028Z","end":"2026-03-31T18:27:16.94641Z","steps":["trace[673594549] 'process raft request' (duration: 100.681407ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:27:29.866702Z","caller":"traceutil/trace.go:171","msg":"trace[1444905292] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"131.337658ms","start":"2026-03-31T18:27:29.735308Z","end":"2026-03-31T18:27:29.866646Z","steps":["trace[1444905292] 'process raft request' (duration: 131.033143ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:27:30.043478Z","caller":"traceutil/trace.go:171","msg":"trace[1209438359] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"169.406488ms","start":"2026-03-31T18:27:29.874033Z","end":"2026-03-31T18:27:30.043439Z","steps":["trace[1209438359] 'process raft request' (duration: 169.222564ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:27:58.138546Z","caller":"traceutil/trace.go:171","msg":"trace[1084306194] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"113.271261ms","start":"2026-03-31T18:27:58.025244Z","end":"2026-03-31T18:27:58.138515Z","steps":["trace[1084306194] 'process raft request' (duration: 113.065497ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:28:45.121406Z","caller":"traceutil/trace.go:171","msg":"trace[1816466310] linearizableReadLoop","detail":"{readStateIndex:1914; appliedIndex:1913; }","duration":"133.28954ms","start":"2026-03-31T18:28:44.988091Z","end":"2026-03-31T18:28:45.12138Z","steps":["trace[1816466310] 'read index received' (duration: 133.094426ms)","trace[1816466310] 'applied index is now lower than readState.Index' (duration: 193.804µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:28:45.121459Z","caller":"traceutil/trace.go:171","msg":"trace[235920112] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"258.124464ms","start":"2026-03-31T18:28:44.863299Z","end":"2026-03-31T18:28:45.121424Z","steps":["trace[235920112] 'process raft request' (duration: 257.93504ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:28:45.12176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.649607ms","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-03-31T18:28:45.121844Z","caller":"traceutil/trace.go:171","msg":"trace[1579883384] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1844; }","duration":"133.782209ms","start":"2026-03-31T18:28:44.988039Z","end":"2026-03-31T18:28:45.121821Z","steps":["trace[1579883384] 'agreement among raft nodes before linearized reading' (duration: 133.514254ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:28:45.594839Z","caller":"traceutil/trace.go:171","msg":"trace[1008883691] linearizableReadLoop","detail":"{readStateIndex:1917; appliedIndex:1916; }","duration":"160.14065ms","start":"2026-03-31T18:28:45.434681Z","end":"2026-03-31T18:28:45.594821Z","steps":["trace[1008883691] 'read index received' (duration: 159.991308ms)","trace[1008883691] 'applied index is now lower than readState.Index' (duration: 148.772µs)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:28:45.595002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.314763ms","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-03-31T18:28:45.595025Z","caller":"traceutil/trace.go:171","msg":"trace[744928498] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1847; }","duration":"160.392125ms","start":"2026-03-31T18:28:45.434627Z","end":"2026-03-31T18:28:45.595019Z","steps":["trace[744928498] 'agreement among raft nodes before linearized reading' (duration: 160.276913ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:28:45.594976Z","caller":"traceutil/trace.go:171","msg":"trace[408845350] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"192.514892ms","start":"2026-03-31T18:28:45.402421Z","end":"2026-03-31T18:28:45.594936Z","steps":["trace[408845350] 'process raft request' (duration: 192.302159ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:28:45.595133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.82319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:28:45.595188Z","caller":"traceutil/trace.go:171","msg":"trace[1998869402] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1847; }","duration":"105.905822ms","start":"2026-03-31T18:28:45.489265Z","end":"2026-03-31T18:28:45.595171Z","steps":["trace[1998869402] 'agreement among raft nodes before linearized reading' (duration: 105.81286ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:28:45.595228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.965191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-31T18:28:45.595326Z","caller":"traceutil/trace.go:171","msg":"trace[1973539869] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1847; }","duration":"121.116834ms","start":"2026-03-31T18:28:45.474187Z","end":"2026-03-31T18:28:45.595304Z","steps":["trace[1973539869] 'agreement among raft nodes before linearized reading' (duration: 120.816838ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:29:04.62884Z","caller":"traceutil/trace.go:171","msg":"trace[1066854531] transaction","detail":"{read_only:false; response_revision:1997; number_of_response:1; }","duration":"156.026974ms","start":"2026-03-31T18:29:04.472769Z","end":"2026-03-31T18:29:04.628796Z","steps":["trace[1066854531] 'process raft request' (duration: 155.75842ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:29:42.779531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.040522ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:29:42.779647Z","caller":"traceutil/trace.go:171","msg":"trace[571422468] linearizableReadLoop","detail":"{readStateIndex:2288; appliedIndex:2287; }","duration":"190.907685ms","start":"2026-03-31T18:29:42.588725Z","end":"2026-03-31T18:29:42.779633Z","steps":["trace[571422468] 'read index received' (duration: 66.293742ms)","trace[571422468] 'applied index is now lower than readState.Index' (duration: 124.612643ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:29:42.779661Z","caller":"traceutil/trace.go:171","msg":"trace[927877970] transaction","detail":"{read_only:false; response_revision:2205; number_of_response:1; }","duration":"212.925642ms","start":"2026-03-31T18:29:42.566713Z","end":"2026-03-31T18:29:42.779639Z","steps":["trace[927877970] 'process raft request' (duration: 88.276248ms)","trace[927877970] 'compare' (duration: 123.93313ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:29:42.779804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.086748ms","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-03-31T18:29:42.779843Z","caller":"traceutil/trace.go:171","msg":"trace[896093928] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2205; }","duration":"191.16534ms","start":"2026-03-31T18:29:42.588668Z","end":"2026-03-31T18:29:42.779833Z","steps":["trace[896093928] 'agreement among raft nodes before linearized reading' (duration: 191.009197ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:29:43.162291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.195673ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:29:43.162369Z","caller":"traceutil/trace.go:171","msg":"trace[1907047935] linearizableReadLoop","detail":"{readStateIndex:2290; appliedIndex:2289; }","duration":"114.956693ms","start":"2026-03-31T18:29:43.047399Z","end":"2026-03-31T18:29:43.162356Z","steps":["trace[1907047935] 'read index received' (duration: 57.161µs)","trace[1907047935] 'applied index is now lower than readState.Index' (duration: 114.898682ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:29:43.162472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.083656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a2008009579098\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-03-31T18:29:43.162421Z","caller":"traceutil/trace.go:171","msg":"trace[1129678197] transaction","detail":"{read_only:false; response_revision:2207; number_of_response:1; }","duration":"328.343345ms","start":"2026-03-31T18:29:42.834044Z","end":"2026-03-31T18:29:43.162388Z","steps":["trace[1129678197] 'process raft request' (duration: 104.990409ms)","trace[1129678197] 'compare' (duration: 223.091131ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:29:43.162502Z","caller":"traceutil/trace.go:171","msg":"trace[1606629450] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18a2008009579098; range_end:; response_count:1; response_revision:2207; }","duration":"115.150817ms","start":"2026-03-31T18:29:43.047344Z","end":"2026-03-31T18:29:43.162495Z","steps":["trace[1606629450] 'agreement among raft nodes before linearized reading' (duration: 115.044975ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:29:43.162664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:29:42.834023Z","time spent":"328.495977ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:30:58.704615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.456572ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:30:58.70471Z","caller":"traceutil/trace.go:171","msg":"trace[1449824610] linearizableReadLoop","detail":"{readStateIndex:2919; appliedIndex:2918; }","duration":"115.343903ms","start":"2026-03-31T18:30:58.589353Z","end":"2026-03-31T18:30:58.704697Z","steps":["trace[1449824610] 'read index received' (duration: 29.681µs)","trace[1449824610] 'applied index is now lower than readState.Index' (duration: 115.313052ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:30:58.704774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.412724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:30:58.704808Z","caller":"traceutil/trace.go:171","msg":"trace[1646016985] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:2811; }","duration":"115.474754ms","start":"2026-03-31T18:30:58.589324Z","end":"2026-03-31T18:30:58.704799Z","steps":["trace[1646016985] 'agreement among raft nodes before linearized reading' (duration: 115.407473ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:30:58.704742Z","caller":"traceutil/trace.go:171","msg":"trace[2048359133] transaction","detail":"{read_only:false; response_revision:2811; number_of_response:1; }","duration":"313.138402ms","start":"2026-03-31T18:30:58.391569Z","end":"2026-03-31T18:30:58.704707Z","steps":["trace[2048359133] 'process raft request' (duration: 120.522307ms)","trace[2048359133] 'compare' (duration: 192.273489ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:30:58.705379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:30:58.391546Z","time spent":"313.468107ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T18:31:04.524655Z","caller":"traceutil/trace.go:171","msg":"trace[756411189] linearizableReadLoop","detail":"{readStateIndex:2951; appliedIndex:2950; }","duration":"107.094397ms","start":"2026-03-31T18:31:04.417535Z","end":"2026-03-31T18:31:04.524629Z","steps":["trace[756411189] 'read index received' (duration: 106.970265ms)","trace[756411189] 'applied index is now lower than readState.Index' (duration: 123.422µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:31:04.524728Z","caller":"traceutil/trace.go:171","msg":"trace[1696919053] transaction","detail":"{read_only:false; response_revision:2842; number_of_response:1; }","duration":"215.066971ms","start":"2026-03-31T18:31:04.309625Z","end":"2026-03-31T18:31:04.524692Z","steps":["trace[1696919053] 'process raft request' (duration: 214.847146ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:04.524872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.312152ms","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-03-31T18:31:04.524901Z","caller":"traceutil/trace.go:171","msg":"trace[1168192244] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2842; }","duration":"107.409514ms","start":"2026-03-31T18:31:04.417483Z","end":"2026-03-31T18:31:04.524893Z","steps":["trace[1168192244] 'agreement among raft nodes before linearized reading' (duration: 107.264641ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:05.435794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.362123ms","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-03-31T18:31:05.435885Z","caller":"traceutil/trace.go:171","msg":"trace[1171715976] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2843; }","duration":"662.515556ms","start":"2026-03-31T18:31:04.773347Z","end":"2026-03-31T18:31:05.435862Z","steps":["trace[1171715976] 'range keys from in-memory index tree' (duration: 661.983586ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:05.435928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:04.773322Z","time spent":"662.596508ms","remote":"127.0.0.1:36972","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":"warn","ts":"2026-03-31T18:31:05.435966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.787447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-03-31T18:31:05.435898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.79921ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:31:05.436067Z","caller":"traceutil/trace.go:171","msg":"trace[277585444] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2843; }","duration":"694.93215ms","start":"2026-03-31T18:31:04.741109Z","end":"2026-03-31T18:31:05.436041Z","steps":["trace[277585444] 'range keys from in-memory index tree' (duration: 694.304669ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:05.436126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:04.741088Z","time spent":"695.028981ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-03-31T18:31:05.436422Z","caller":"traceutil/trace.go:171","msg":"trace[1782783732] transaction","detail":"{read_only:false; response_revision:2844; number_of_response:1; }","duration":"605.440381ms","start":"2026-03-31T18:31:04.830965Z","end":"2026-03-31T18:31:05.436405Z","steps":["trace[1782783732] 'process raft request' (duration: 317.948499ms)","trace[1782783732] 'compare' (duration: 286.636046ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:31:05.436546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:04.830935Z","time spent":"605.531524ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T18:31:05.436748Z","caller":"traceutil/trace.go:171","msg":"trace[1851613222] transaction","detail":"{read_only:false; response_revision:2846; number_of_response:1; }","duration":"329.171799ms","start":"2026-03-31T18:31:05.107549Z","end":"2026-03-31T18:31:05.436721Z","steps":["trace[1851613222] 'process raft request' (duration: 329.118998ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:05.436892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:05.107533Z","time spent":"329.276282ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T18:31:05.437368Z","caller":"traceutil/trace.go:171","msg":"trace[872576951] linearizableReadLoop","detail":"{readStateIndex:2953; appliedIndex:2952; }","duration":"529.256921ms","start":"2026-03-31T18:31:04.908081Z","end":"2026-03-31T18:31:05.437338Z","steps":["trace[872576951] 'read index received' (duration: 240.836402ms)","trace[872576951] 'applied index is now lower than readState.Index' (duration: 288.419129ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:31:05.437493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.397543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:31:05.437506Z","caller":"traceutil/trace.go:171","msg":"trace[1128994501] transaction","detail":"{read_only:false; response_revision:2845; number_of_response:1; }","duration":"346.205077ms","start":"2026-03-31T18:31:05.091257Z","end":"2026-03-31T18:31:05.437462Z","steps":["trace[1128994501] 'process raft request' (duration: 345.2379ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:31:05.437535Z","caller":"traceutil/trace.go:171","msg":"trace[1372796975] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:2846; }","duration":"529.496975ms","start":"2026-03-31T18:31:04.908027Z","end":"2026-03-31T18:31:05.437524Z","steps":["trace[1372796975] 'agreement among raft nodes before linearized reading' (duration: 529.411584ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:05.437576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:04.908004Z","time spent":"529.561217ms","remote":"127.0.0.1:39604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-03-31T18:31:05.43768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:05.091227Z","time spent":"346.32717ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:31:05.737547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.982256ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:31:05.737791Z","caller":"traceutil/trace.go:171","msg":"trace[1874211182] linearizableReadLoop","detail":"{readStateIndex:2956; appliedIndex:2955; }","duration":"294.368951ms","start":"2026-03-31T18:31:05.443377Z","end":"2026-03-31T18:31:05.737746Z","steps":["trace[1874211182] 'read index received' (duration: 134.961387ms)","trace[1874211182] 'applied index is now lower than readState.Index' (duration: 159.405023ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:31:05.737935Z","caller":"traceutil/trace.go:171","msg":"trace[1867153518] transaction","detail":"{read_only:false; response_revision:2847; number_of_response:1; }","duration":"297.041551ms","start":"2026-03-31T18:31:05.440876Z","end":"2026-03-31T18:31:05.737918Z","steps":["trace[1867153518] 'process raft request' (duration: 137.489505ms)","trace[1867153518] 'compare' (duration: 158.816742ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:31:05.73806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.688956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1315"} {"level":"info","ts":"2026-03-31T18:31:05.738144Z","caller":"traceutil/trace.go:171","msg":"trace[1255291708] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:2847; }","duration":"294.796297ms","start":"2026-03-31T18:31:05.443338Z","end":"2026-03-31T18:31:05.738134Z","steps":["trace[1255291708] 'agreement among raft nodes before linearized reading' (duration: 294.601774ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:31:06.010404Z","caller":"traceutil/trace.go:171","msg":"trace[1265350563] linearizableReadLoop","detail":"{readStateIndex:2957; appliedIndex:2956; }","duration":"272.512963ms","start":"2026-03-31T18:31:05.737862Z","end":"2026-03-31T18:31:06.010375Z","steps":["trace[1265350563] 'read index received' (duration: 272.389691ms)","trace[1265350563] 'applied index is now lower than readState.Index' (duration: 121.632µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:31:06.010898Z","caller":"traceutil/trace.go:171","msg":"trace[49661405] transaction","detail":"{read_only:false; response_revision:2848; number_of_response:1; }","duration":"308.405602ms","start":"2026-03-31T18:31:05.702478Z","end":"2026-03-31T18:31:06.010884Z","steps":["trace[49661405] 'process raft request' (duration: 307.71559ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:06.011033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:05.702453Z","time spent":"308.491313ms","remote":"127.0.0.1:37058","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-03-31T18:31:06.011362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.946636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/auth-system/keycloak\" ","response":"range_response_count:1 size:7460"} {"level":"info","ts":"2026-03-31T18:31:06.011487Z","caller":"traceutil/trace.go:171","msg":"trace[1007457686] range","detail":"{range_begin:/registry/statefulsets/auth-system/keycloak; range_end:; response_count:1; response_revision:2848; }","duration":"269.1261ms","start":"2026-03-31T18:31:05.742336Z","end":"2026-03-31T18:31:06.011462Z","steps":["trace[1007457686] 'agreement among raft nodes before linearized reading' (duration: 268.741613ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:06.011537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.159184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-03-31T18:31:06.011801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.142457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-03-31T18:31:06.011392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.136919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:31:06.011903Z","caller":"traceutil/trace.go:171","msg":"trace[1895180944] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:2848; }","duration":"180.686029ms","start":"2026-03-31T18:31:05.831198Z","end":"2026-03-31T18:31:06.011884Z","steps":["trace[1895180944] 'agreement among raft nodes before linearized reading' (duration: 180.149338ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:06.01195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.22218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-03-31T18:31:06.011999Z","caller":"traceutil/trace.go:171","msg":"trace[1640192417] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2848; }","duration":"181.360393ms","start":"2026-03-31T18:31:05.830624Z","end":"2026-03-31T18:31:06.011985Z","steps":["trace[1640192417] 'agreement among raft nodes before linearized reading' (duration: 181.249131ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:31:06.011853Z","caller":"traceutil/trace.go:171","msg":"trace[512200680] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2848; }","duration":"219.221599ms","start":"2026-03-31T18:31:05.792618Z","end":"2026-03-31T18:31:06.01184Z","steps":["trace[512200680] 'agreement among raft nodes before linearized reading' (duration: 219.094727ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:06.012583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.682122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:31:06.012625Z","caller":"traceutil/trace.go:171","msg":"trace[1574978964] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2848; }","duration":"527.748093ms","start":"2026-03-31T18:31:05.484867Z","end":"2026-03-31T18:31:06.012615Z","steps":["trace[1574978964] 'agreement among raft nodes before linearized reading' (duration: 527.686742ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:06.012654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:05.484856Z","time spent":"527.791304ms","remote":"127.0.0.1:36778","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-03-31T18:31:06.01158Z","caller":"traceutil/trace.go:171","msg":"trace[1821217645] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2848; }","duration":"437.243925ms","start":"2026-03-31T18:31:05.574325Z","end":"2026-03-31T18:31:06.011569Z","steps":["trace[1821217645] 'agreement among raft nodes before linearized reading' (duration: 437.100053ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:06.01296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:05.574263Z","time spent":"438.681402ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-31T18:31:06.43761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.581886ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:31:06.437933Z","caller":"traceutil/trace.go:171","msg":"trace[1416274184] transaction","detail":"{read_only:false; response_revision:2849; number_of_response:1; }","duration":"421.457971ms","start":"2026-03-31T18:31:06.016438Z","end":"2026-03-31T18:31:06.437896Z","steps":["trace[1416274184] 'process raft request' (duration: 126.760935ms)","trace[1416274184] 'compare' (duration: 293.399682ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:31:06.43806Z","caller":"traceutil/trace.go:171","msg":"trace[1774493167] transaction","detail":"{read_only:false; response_revision:2850; number_of_response:1; }","duration":"420.540494ms","start":"2026-03-31T18:31:06.017482Z","end":"2026-03-31T18:31:06.438022Z","steps":["trace[1774493167] 'process raft request' (duration: 420.32333ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:31:06.438097Z","caller":"traceutil/trace.go:171","msg":"trace[285394879] transaction","detail":"{read_only:false; response_revision:2851; number_of_response:1; }","duration":"419.619327ms","start":"2026-03-31T18:31:06.018432Z","end":"2026-03-31T18:31:06.438051Z","steps":["trace[285394879] 'process raft request' (duration: 419.500245ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:06.438131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:06.016416Z","time spent":"421.591604ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T18:31:06.438193Z","caller":"traceutil/trace.go:171","msg":"trace[800618104] linearizableReadLoop","detail":"{readStateIndex:2960; appliedIndex:2957; }","duration":"381.404814ms","start":"2026-03-31T18:31:06.05657Z","end":"2026-03-31T18:31:06.437975Z","steps":["trace[800618104] 'read index received' (duration: 86.656046ms)","trace[800618104] 'applied index is now lower than readState.Index' (duration: 294.747748ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:31:06.438233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:06.01747Z","time spent":"420.686777ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:31:06.438293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:06.018416Z","time spent":"419.75015ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:31:06.438839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.270711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18a200935cb9e908\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-03-31T18:31:06.438927Z","caller":"traceutil/trace.go:171","msg":"trace[263708009] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18a200935cb9e908; range_end:; response_count:1; response_revision:2851; }","duration":"382.404293ms","start":"2026-03-31T18:31:06.056509Z","end":"2026-03-31T18:31:06.438913Z","steps":["trace[263708009] 'agreement among raft nodes before linearized reading' (duration: 381.753041ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:06.439712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:06.056485Z","time spent":"383.211067ms","remote":"127.0.0.1:36858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":804,"request content":"key:\"/registry/events/auth-system/keycloak-0.18a200935cb9e908\" "} {"level":"info","ts":"2026-03-31T18:31:06.877226Z","caller":"traceutil/trace.go:171","msg":"trace[1717318897] linearizableReadLoop","detail":"{readStateIndex:2962; appliedIndex:2961; }","duration":"347.200935ms","start":"2026-03-31T18:31:06.529998Z","end":"2026-03-31T18:31:06.877199Z","steps":["trace[1717318897] 'read index received' (duration: 346.981191ms)","trace[1717318897] 'applied index is now lower than readState.Index' (duration: 218.764µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:31:06.87732Z","caller":"traceutil/trace.go:171","msg":"trace[265465905] transaction","detail":"{read_only:false; response_revision:2853; number_of_response:1; }","duration":"375.229088ms","start":"2026-03-31T18:31:06.502033Z","end":"2026-03-31T18:31:06.877262Z","steps":["trace[265465905] 'process raft request' (duration: 374.989674ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:06.877437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.458618ms","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-03-31T18:31:06.877479Z","caller":"traceutil/trace.go:171","msg":"trace[1118451417] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2853; }","duration":"290.545799ms","start":"2026-03-31T18:31:06.586919Z","end":"2026-03-31T18:31:06.877465Z","steps":["trace[1118451417] 'agreement among raft nodes before linearized reading' (duration: 290.423046ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:06.877529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.4931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-03-31T18:31:06.877555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.977421ms","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-03-31T18:31:06.877634Z","caller":"traceutil/trace.go:171","msg":"trace[311217895] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2853; }","duration":"103.095783ms","start":"2026-03-31T18:31:06.774518Z","end":"2026-03-31T18:31:06.877613Z","steps":["trace[311217895] 'agreement among raft nodes before linearized reading' (duration: 102.9219ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:31:06.877634Z","caller":"traceutil/trace.go:171","msg":"trace[1485267929] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2853; }","duration":"347.634112ms","start":"2026-03-31T18:31:06.529971Z","end":"2026-03-31T18:31:06.877606Z","steps":["trace[1485267929] 'agreement among raft nodes before linearized reading' (duration: 347.325757ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:06.877558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:06.502017Z","time spent":"375.419441ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:31:06.877697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:06.52996Z","time spent":"347.722684ms","remote":"127.0.0.1:37058","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-03-31T18:31:06.877701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.228773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12211"} {"level":"info","ts":"2026-03-31T18:31:06.877775Z","caller":"traceutil/trace.go:171","msg":"trace[2027182667] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2853; }","duration":"252.355686ms","start":"2026-03-31T18:31:06.625403Z","end":"2026-03-31T18:31:06.877759Z","steps":["trace[2027182667] 'agreement among raft nodes before linearized reading' (duration: 252.139472ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:07.543694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.434459ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:31:07.543883Z","caller":"traceutil/trace.go:171","msg":"trace[453103583] linearizableReadLoop","detail":"{readStateIndex:2964; appliedIndex:2962; }","duration":"662.030748ms","start":"2026-03-31T18:31:06.881836Z","end":"2026-03-31T18:31:07.543867Z","steps":["trace[453103583] 'read index received' (duration: 380.357355ms)","trace[453103583] 'applied index is now lower than readState.Index' (duration: 281.672543ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:31:07.543951Z","caller":"traceutil/trace.go:171","msg":"trace[476637214] transaction","detail":"{read_only:false; response_revision:2855; number_of_response:1; }","duration":"662.339644ms","start":"2026-03-31T18:31:06.881602Z","end":"2026-03-31T18:31:07.543941Z","steps":["trace[476637214] 'process raft request' (duration: 662.203121ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:07.544016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:06.881591Z","time spent":"662.391394ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T18:31:07.544032Z","caller":"traceutil/trace.go:171","msg":"trace[1744662357] transaction","detail":"{read_only:false; response_revision:2854; number_of_response:1; }","duration":"662.507777ms","start":"2026-03-31T18:31:06.881492Z","end":"2026-03-31T18:31:07.544Z","steps":["trace[1744662357] 'process raft request' (duration: 380.688841ms)","trace[1744662357] 'compare' (duration: 281.337847ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:31:07.544178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:06.881477Z","time spent":"662.622388ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:31:07.544298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.460766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9401"} {"level":"info","ts":"2026-03-31T18:31:07.544343Z","caller":"traceutil/trace.go:171","msg":"trace[598608607] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:2855; }","duration":"662.517817ms","start":"2026-03-31T18:31:06.881812Z","end":"2026-03-31T18:31:07.544329Z","steps":["trace[598608607] 'agreement among raft nodes before linearized reading' (duration: 662.373894ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:07.544373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:06.881795Z","time spent":"662.572117ms","remote":"127.0.0.1:36958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":9424,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-03-31T18:31:08.585123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"773.264604ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-03-31T18:31:08.586161Z","caller":"traceutil/trace.go:171","msg":"trace[1766147864] transaction","detail":"{read_only:false; response_revision:2856; number_of_response:1; }","duration":"1.144805822s","start":"2026-03-31T18:31:07.441328Z","end":"2026-03-31T18:31:08.586133Z","steps":["trace[1766147864] 'process raft request' (duration: 1.143924926s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:08.586304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:07.441304Z","time spent":"1.144913133s","remote":"127.0.0.1:37058","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-03-31T18:31:08.817505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.301364ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:31:08.817725Z","caller":"traceutil/trace.go:171","msg":"trace[1888898714] linearizableReadLoop","detail":"{readStateIndex:2968; appliedIndex:2964; }","duration":"1.273798009s","start":"2026-03-31T18:31:07.54391Z","end":"2026-03-31T18:31:08.817708Z","steps":["trace[1888898714] 'read index received' (duration: 267.848175ms)","trace[1888898714] 'applied index is now lower than readState.Index' (duration: 1.005948864s)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:31:08.817842Z","caller":"traceutil/trace.go:171","msg":"trace[1393911913] transaction","detail":"{read_only:false; response_revision:2859; number_of_response:1; }","duration":"800.749456ms","start":"2026-03-31T18:31:08.017069Z","end":"2026-03-31T18:31:08.817819Z","steps":["trace[1393911913] 'process raft request' (duration: 800.608993ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:08.817899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.710448103s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-03-31T18:31:08.817879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.330919104s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:31:08.81793Z","caller":"traceutil/trace.go:171","msg":"trace[1313319611] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:2859; }","duration":"1.710509015s","start":"2026-03-31T18:31:07.107413Z","end":"2026-03-31T18:31:08.817922Z","steps":["trace[1313319611] 'agreement among raft nodes before linearized reading' (duration: 1.710390852s)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:31:08.81795Z","caller":"traceutil/trace.go:171","msg":"trace[931215155] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2859; }","duration":"1.331038277s","start":"2026-03-31T18:31:07.486894Z","end":"2026-03-31T18:31:08.817932Z","steps":["trace[931215155] 'agreement among raft nodes before linearized reading' (duration: 1.330870204s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:08.817973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:08.017049Z","time spent":"800.849318ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:31:08.817997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:07.486871Z","time spent":"1.331118768s","remote":"127.0.0.1:36778","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-03-31T18:31:08.818093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.722581449s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-03-31T18:31:08.818134Z","caller":"traceutil/trace.go:171","msg":"trace[1311788592] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2859; }","duration":"1.722677301s","start":"2026-03-31T18:31:07.095445Z","end":"2026-03-31T18:31:08.818122Z","steps":["trace[1311788592] 'agreement among raft nodes before linearized reading' (duration: 1.722533429s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:08.818161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:07.095426Z","time spent":"1.722728532s","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-03-31T18:31:08.818215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.933094ms","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-03-31T18:31:08.818248Z","caller":"traceutil/trace.go:171","msg":"trace[1402323830] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2859; }","duration":"374.994944ms","start":"2026-03-31T18:31:08.443245Z","end":"2026-03-31T18:31:08.81824Z","steps":["trace[1402323830] 'agreement among raft nodes before linearized reading' (duration: 374.901093ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:08.81827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:08.443221Z","time spent":"375.044206ms","remote":"127.0.0.1:37058","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-03-31T18:31:08.817962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:07.107401Z","time spent":"1.710551925s","remote":"127.0.0.1:36914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":10,"response size":30,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"info","ts":"2026-03-31T18:31:08.818217Z","caller":"traceutil/trace.go:171","msg":"trace[1240149489] transaction","detail":"{read_only:false; response_revision:2857; number_of_response:1; }","duration":"1.375584707s","start":"2026-03-31T18:31:07.442617Z","end":"2026-03-31T18:31:08.818201Z","steps":["trace[1240149489] 'process raft request' (duration: 1.143503047s)","trace[1240149489] 'compare' (duration: 231.182222ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:31:08.818504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:07.442594Z","time spent":"1.375868881s","remote":"127.0.0.1:37058","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-03-31T18:31:08.818524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.935052522s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1315"} {"level":"warn","ts":"2026-03-31T18:31:08.818516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.155582ms","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-03-31T18:31:08.818577Z","caller":"traceutil/trace.go:171","msg":"trace[1786297528] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:2859; }","duration":"1.935238215s","start":"2026-03-31T18:31:06.88332Z","end":"2026-03-31T18:31:08.818559Z","steps":["trace[1786297528] 'agreement among raft nodes before linearized reading' (duration: 1.934731766s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:08.818513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.072636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-03-31T18:31:08.818621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:06.883295Z","time spent":"1.935314647s","remote":"127.0.0.1:36972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":1338,"request content":"key:\"/registry/services/specs/auth-system/keycloak\" "} {"level":"info","ts":"2026-03-31T18:31:08.818621Z","caller":"traceutil/trace.go:171","msg":"trace[1537792281] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2859; }","duration":"375.224659ms","start":"2026-03-31T18:31:08.443387Z","end":"2026-03-31T18:31:08.818612Z","steps":["trace[1537792281] 'agreement among raft nodes before linearized reading' (duration: 375.035496ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:08.818612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.342662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:31:08.818252Z","caller":"traceutil/trace.go:171","msg":"trace[1817958560] transaction","detail":"{read_only:false; response_revision:2858; number_of_response:1; }","duration":"1.373798903s","start":"2026-03-31T18:31:07.444445Z","end":"2026-03-31T18:31:08.818243Z","steps":["trace[1817958560] 'process raft request' (duration: 1.373168282s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:08.818663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:08.443351Z","time spent":"375.301141ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-31T18:31:08.818673Z","caller":"traceutil/trace.go:171","msg":"trace[918567725] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:2859; }","duration":"418.453505ms","start":"2026-03-31T18:31:08.400206Z","end":"2026-03-31T18:31:08.81866Z","steps":["trace[918567725] 'agreement among raft nodes before linearized reading' (duration: 418.320422ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:08.818567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.3524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:31:08.818691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.075695883s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-03-31T18:31:08.818674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"819.141238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-31T18:31:08.81874Z","caller":"traceutil/trace.go:171","msg":"trace[2030423339] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2859; }","duration":"1.075777105s","start":"2026-03-31T18:31:07.742952Z","end":"2026-03-31T18:31:08.818729Z","steps":["trace[2030423339] 'agreement among raft nodes before linearized reading' (duration: 1.075664153s)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:31:08.818738Z","caller":"traceutil/trace.go:171","msg":"trace[999789101] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2859; }","duration":"101.541584ms","start":"2026-03-31T18:31:08.71717Z","end":"2026-03-31T18:31:08.818712Z","steps":["trace[999789101] 'agreement among raft nodes before linearized reading' (duration: 101.372531ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:08.818769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:07.742932Z","time spent":"1.075829366s","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-03-31T18:31:08.81876Z","caller":"traceutil/trace.go:171","msg":"trace[2139246560] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:2859; }","duration":"819.283471ms","start":"2026-03-31T18:31:07.999457Z","end":"2026-03-31T18:31:08.818741Z","steps":["trace[2139246560] 'agreement among raft nodes before linearized reading' (duration: 819.083158ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:08.818699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.789398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:31:08.818854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:07.999435Z","time spent":"819.407413ms","remote":"127.0.0.1:36986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":59,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"info","ts":"2026-03-31T18:31:08.818681Z","caller":"traceutil/trace.go:171","msg":"trace[1976049887] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:2859; }","duration":"639.317494ms","start":"2026-03-31T18:31:08.179307Z","end":"2026-03-31T18:31:08.818625Z","steps":["trace[1976049887] 'agreement among raft nodes before linearized reading' (duration: 639.10954ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:08.818706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:08.400183Z","time spent":"418.516556ms","remote":"127.0.0.1:37038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-03-31T18:31:08.819008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:08.179286Z","time spent":"639.705213ms","remote":"127.0.0.1:37264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":3,"response size":30,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-03-31T18:31:08.819015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.219557757s","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-03-31T18:31:08.819102Z","caller":"traceutil/trace.go:171","msg":"trace[675240272] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2859; }","duration":"1.220444913s","start":"2026-03-31T18:31:07.598638Z","end":"2026-03-31T18:31:08.819083Z","steps":["trace[675240272] 'agreement among raft nodes before linearized reading' (duration: 1.219462155s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:08.819144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:07.598621Z","time spent":"1.220509935s","remote":"127.0.0.1:37220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-03-31T18:31:08.819055Z","caller":"traceutil/trace.go:171","msg":"trace[1078582148] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:2859; }","duration":"109.038273ms","start":"2026-03-31T18:31:08.709806Z","end":"2026-03-31T18:31:08.818844Z","steps":["trace[1078582148] 'agreement among raft nodes before linearized reading' (duration: 108.755778ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:08.819768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:07.444429Z","time spent":"1.374242561s","remote":"127.0.0.1:37058","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-03-31T18:31:09.276364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.024402ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:31:09.276673Z","caller":"traceutil/trace.go:171","msg":"trace[727403082] transaction","detail":"{read_only:false; response_revision:2860; number_of_response:1; }","duration":"453.62296ms","start":"2026-03-31T18:31:08.823018Z","end":"2026-03-31T18:31:09.276641Z","steps":["trace[727403082] 'process raft request' (duration: 99.230391ms)","trace[727403082] 'compare' (duration: 353.798278ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:31:09.276716Z","caller":"traceutil/trace.go:171","msg":"trace[799494097] linearizableReadLoop","detail":"{readStateIndex:2972; appliedIndex:2969; }","duration":"452.390387ms","start":"2026-03-31T18:31:08.824298Z","end":"2026-03-31T18:31:09.276689Z","steps":["trace[799494097] 'read index received' (duration: 98.035698ms)","trace[799494097] 'applied index is now lower than readState.Index' (duration: 354.353529ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:31:09.276824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:08.823009Z","time spent":"453.738743ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T18:31:09.276955Z","caller":"traceutil/trace.go:171","msg":"trace[1495700502] transaction","detail":"{read_only:false; response_revision:2861; number_of_response:1; }","duration":"453.316065ms","start":"2026-03-31T18:31:08.823627Z","end":"2026-03-31T18:31:09.276943Z","steps":["trace[1495700502] 'process raft request' (duration: 452.859155ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:09.277013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:08.82361Z","time spent":"453.372126ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T18:31:09.276982Z","caller":"traceutil/trace.go:171","msg":"trace[746505038] transaction","detail":"{read_only:false; response_revision:2863; number_of_response:1; }","duration":"452.153643ms","start":"2026-03-31T18:31:08.824751Z","end":"2026-03-31T18:31:09.276905Z","steps":["trace[746505038] 'process raft request' (duration: 451.887607ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:31:09.277097Z","caller":"traceutil/trace.go:171","msg":"trace[1945569016] transaction","detail":"{read_only:false; response_revision:2862; number_of_response:1; }","duration":"452.812606ms","start":"2026-03-31T18:31:08.824276Z","end":"2026-03-31T18:31:09.277089Z","steps":["trace[1945569016] 'process raft request' (duration: 452.311976ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:09.277142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:08.824264Z","time spent":"452.853827ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:31:09.277294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.983309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12211"} {"level":"warn","ts":"2026-03-31T18:31:09.27734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:08.824745Z","time spent":"452.408527ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:31:09.277444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.236721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-31T18:31:09.277499Z","caller":"traceutil/trace.go:171","msg":"trace[1996443829] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:2863; }","duration":"410.329642ms","start":"2026-03-31T18:31:08.867153Z","end":"2026-03-31T18:31:09.277483Z","steps":["trace[1996443829] 'agreement among raft nodes before linearized reading' (duration: 410.245141ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:09.277555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:08.867126Z","time spent":"410.415154ms","remote":"127.0.0.1:37214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-03-31T18:31:09.277354Z","caller":"traceutil/trace.go:171","msg":"trace[1307968437] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2863; }","duration":"453.05973ms","start":"2026-03-31T18:31:08.82428Z","end":"2026-03-31T18:31:09.27734Z","steps":["trace[1307968437] 'agreement among raft nodes before linearized reading' (duration: 452.872866ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:09.277711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.192879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-03-31T18:31:09.277678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:08.824272Z","time spent":"453.390466ms","remote":"127.0.0.1:36968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12234,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-03-31T18:31:09.277768Z","caller":"traceutil/trace.go:171","msg":"trace[2087454012] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:2863; }","duration":"292.304251ms","start":"2026-03-31T18:31:08.985452Z","end":"2026-03-31T18:31:09.277756Z","steps":["trace[2087454012] 'agreement among raft nodes before linearized reading' (duration: 292.194169ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:09.846281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.91564ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:31:09.846443Z","caller":"traceutil/trace.go:171","msg":"trace[1129439533] transaction","detail":"{read_only:false; response_revision:2864; number_of_response:1; }","duration":"502.614405ms","start":"2026-03-31T18:31:09.3438Z","end":"2026-03-31T18:31:09.846415Z","steps":["trace[1129439533] 'process raft request' (duration: 317.42025ms)","trace[1129439533] 'compare' (duration: 184.320359ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:31:09.84652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:09.343766Z","time spent":"502.716487ms","remote":"127.0.0.1:37058","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-03-31T18:31:10.281853Z","caller":"traceutil/trace.go:171","msg":"trace[148954607] linearizableReadLoop","detail":"{readStateIndex:2975; appliedIndex:2973; }","duration":"875.302286ms","start":"2026-03-31T18:31:09.406526Z","end":"2026-03-31T18:31:10.281828Z","steps":["trace[148954607] 'read index received' (duration: 254.65595ms)","trace[148954607] 'applied index is now lower than readState.Index' (duration: 620.645366ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:31:10.281971Z","caller":"traceutil/trace.go:171","msg":"trace[1955886268] transaction","detail":"{read_only:false; response_revision:2865; number_of_response:1; }","duration":"900.445715ms","start":"2026-03-31T18:31:09.381483Z","end":"2026-03-31T18:31:10.281929Z","steps":["trace[1955886268] 'process raft request' (duration: 860.801605ms)","trace[1955886268] 'compare' (duration: 39.10874ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:31:10.282054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"875.530112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-31T18:31:10.282124Z","caller":"traceutil/trace.go:171","msg":"trace[636282670] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:2865; }","duration":"875.688104ms","start":"2026-03-31T18:31:09.406425Z","end":"2026-03-31T18:31:10.282113Z","steps":["trace[636282670] 'agreement among raft nodes before linearized reading' (duration: 875.550791ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:10.282149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.681778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/valkey-node-0.18a200943059d1ce\" ","response":"range_response_count:1 size:765"} {"level":"warn","ts":"2026-03-31T18:31:10.28216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:09.406376Z","time spent":"875.774436ms","remote":"127.0.0.1:36902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":30,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"info","ts":"2026-03-31T18:31:10.282186Z","caller":"traceutil/trace.go:171","msg":"trace[1146319874] range","detail":"{range_begin:/registry/events/openstack/valkey-node-0.18a200943059d1ce; range_end:; response_count:1; response_revision:2865; }","duration":"673.773958ms","start":"2026-03-31T18:31:09.608403Z","end":"2026-03-31T18:31:10.282177Z","steps":["trace[1146319874] 'agreement among raft nodes before linearized reading' (duration: 673.611646ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:10.282207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:09.60838Z","time spent":"673.82241ms","remote":"127.0.0.1:36858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":788,"request content":"key:\"/registry/events/openstack/valkey-node-0.18a200943059d1ce\" "} {"level":"warn","ts":"2026-03-31T18:31:10.282189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:09.381457Z","time spent":"900.63391ms","remote":"127.0.0.1:37058","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-03-31T18:31:10.282194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.45537ms","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-03-31T18:31:10.282285Z","caller":"traceutil/trace.go:171","msg":"trace[550174380] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2865; }","duration":"734.609443ms","start":"2026-03-31T18:31:09.547654Z","end":"2026-03-31T18:31:10.282264Z","steps":["trace[550174380] 'agreement among raft nodes before linearized reading' (duration: 734.337528ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:10.2823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.330654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-03-31T18:31:10.282333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:09.547627Z","time spent":"734.696954ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-03-31T18:31:10.282372Z","caller":"traceutil/trace.go:171","msg":"trace[610872934] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:2865; }","duration":"180.424896ms","start":"2026-03-31T18:31:10.101921Z","end":"2026-03-31T18:31:10.282346Z","steps":["trace[610872934] 'agreement among raft nodes before linearized reading' (duration: 180.337875ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:10.282185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.717438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-03-31T18:31:10.282458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.953332ms","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-03-31T18:31:10.282482Z","caller":"traceutil/trace.go:171","msg":"trace[1450136121] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2865; }","duration":"733.012744ms","start":"2026-03-31T18:31:09.549463Z","end":"2026-03-31T18:31:10.282476Z","steps":["trace[1450136121] 'agreement among raft nodes before linearized reading' (duration: 732.948743ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:31:10.282474Z","caller":"traceutil/trace.go:171","msg":"trace[1781183955] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2865; }","duration":"517.116866ms","start":"2026-03-31T18:31:09.765343Z","end":"2026-03-31T18:31:10.28246Z","steps":["trace[1781183955] 'agreement among raft nodes before linearized reading' (duration: 516.662797ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:31:10.282503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:09.549443Z","time spent":"733.055474ms","remote":"127.0.0.1:37058","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-03-31T18:31:10.282521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:31:09.76531Z","time spent":"517.193447ms","remote":"127.0.0.1:48756","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-03-31T18:33:29.541959Z","caller":"traceutil/trace.go:171","msg":"trace[590994596] transaction","detail":"{read_only:false; response_revision:3798; number_of_response:1; }","duration":"216.00404ms","start":"2026-03-31T18:33:29.32593Z","end":"2026-03-31T18:33:29.541934Z","steps":["trace[590994596] 'process raft request' (duration: 215.828117ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:33:29.542144Z","caller":"traceutil/trace.go:171","msg":"trace[334690698] transaction","detail":"{read_only:false; response_revision:3799; number_of_response:1; }","duration":"215.694175ms","start":"2026-03-31T18:33:29.326431Z","end":"2026-03-31T18:33:29.542125Z","steps":["trace[334690698] 'process raft request' (duration: 215.46233ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:34:54.163235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.789155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-djnhd.18a200cef6051e0f\" ","response":"range_response_count:1 size:962"} {"level":"info","ts":"2026-03-31T18:34:54.163333Z","caller":"traceutil/trace.go:171","msg":"trace[814681018] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-djnhd.18a200cef6051e0f; range_end:; response_count:1; response_revision:4967; }","duration":"104.914528ms","start":"2026-03-31T18:34:54.058401Z","end":"2026-03-31T18:34:54.163316Z","steps":["trace[814681018] 'range keys from in-memory index tree' (duration: 104.673603ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:34:54.163762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.873215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-725e6ae3-ffac-48b5-9097-c5728df28a59\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-03-31T18:34:54.163833Z","caller":"traceutil/trace.go:171","msg":"trace[1831038656] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-725e6ae3-ffac-48b5-9097-c5728df28a59; range_end:; response_count:1; response_revision:4967; }","duration":"108.450545ms","start":"2026-03-31T18:34:54.055367Z","end":"2026-03-31T18:34:54.163817Z","steps":["trace[1831038656] 'range keys from in-memory index tree' (duration: 107.71281ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:34:54.367401Z","caller":"traceutil/trace.go:171","msg":"trace[496842644] linearizableReadLoop","detail":"{readStateIndex:5157; appliedIndex:5156; }","duration":"170.383276ms","start":"2026-03-31T18:34:54.196993Z","end":"2026-03-31T18:34:54.367377Z","steps":["trace[496842644] 'read index received' (duration: 170.230073ms)","trace[496842644] 'applied index is now lower than readState.Index' (duration: 152.183µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:34:54.367451Z","caller":"traceutil/trace.go:171","msg":"trace[1216616793] transaction","detail":"{read_only:false; response_revision:4969; number_of_response:1; }","duration":"196.996676ms","start":"2026-03-31T18:34:54.170422Z","end":"2026-03-31T18:34:54.367419Z","steps":["trace[1216616793] 'process raft request' (duration: 196.784192ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:34:54.367541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.135502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:34:54.367577Z","caller":"traceutil/trace.go:171","msg":"trace[634527521] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:4969; }","duration":"178.251544ms","start":"2026-03-31T18:34:54.189318Z","end":"2026-03-31T18:34:54.36757Z","steps":["trace[634527521] 'agreement among raft nodes before linearized reading' (duration: 178.157863ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:34:54.378886Z","caller":"traceutil/trace.go:171","msg":"trace[1305628884] transaction","detail":"{read_only:false; response_revision:4970; number_of_response:1; }","duration":"110.465883ms","start":"2026-03-31T18:34:54.268407Z","end":"2026-03-31T18:34:54.378873Z","steps":["trace[1305628884] 'process raft request' (duration: 110.323579ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:35:13.551798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.635544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-31T18:35:13.551898Z","caller":"traceutil/trace.go:171","msg":"trace[1939839225] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:5361; }","duration":"128.787646ms","start":"2026-03-31T18:35:13.423089Z","end":"2026-03-31T18:35:13.551876Z","steps":["trace[1939839225] 'count revisions from in-memory index tree' (duration: 128.551482ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:35:13.783829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.260533ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:35:13.784117Z","caller":"traceutil/trace.go:171","msg":"trace[1019211502] transaction","detail":"{read_only:false; response_revision:5364; number_of_response:1; }","duration":"166.397072ms","start":"2026-03-31T18:35:13.617688Z","end":"2026-03-31T18:35:13.784085Z","steps":["trace[1019211502] 'process raft request' (duration: 34.820743ms)","trace[1019211502] 'compare' (duration: 131.158072ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:35:14.149293Z","caller":"traceutil/trace.go:171","msg":"trace[1027746307] transaction","detail":"{read_only:false; response_revision:5366; number_of_response:1; }","duration":"145.108003ms","start":"2026-03-31T18:35:14.004146Z","end":"2026-03-31T18:35:14.149254Z","steps":["trace[1027746307] 'process raft request' (duration: 144.853168ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:35:14.156427Z","caller":"traceutil/trace.go:171","msg":"trace[491628700] transaction","detail":"{read_only:false; response_revision:5367; number_of_response:1; }","duration":"143.998302ms","start":"2026-03-31T18:35:14.0124Z","end":"2026-03-31T18:35:14.156398Z","steps":["trace[491628700] 'process raft request' (duration: 143.828639ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:36:15.924742Z","caller":"traceutil/trace.go:171","msg":"trace[1618075998] transaction","detail":"{read_only:false; response_revision:5926; number_of_response:1; }","duration":"131.94987ms","start":"2026-03-31T18:36:15.792762Z","end":"2026-03-31T18:36:15.924712Z","steps":["trace[1618075998] 'process raft request' (duration: 131.779686ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:36:39.08024Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3024} {"level":"info","ts":"2026-03-31T18:36:39.162044Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3024,"took":"80.263132ms","hash":1512360930,"current-db-size-bytes":58470400,"current-db-size":"58 MB","current-db-size-in-use-bytes":31551488,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-03-31T18:36:39.162114Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1512360930,"revision":3024,"compact-revision":-1} {"level":"warn","ts":"2026-03-31T18:41:25.973932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.892819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12211"} {"level":"info","ts":"2026-03-31T18:41:25.97402Z","caller":"traceutil/trace.go:171","msg":"trace[2106212391] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8230; }","duration":"200.020332ms","start":"2026-03-31T18:41:25.773981Z","end":"2026-03-31T18:41:25.974001Z","steps":["trace[2106212391] 'range keys from in-memory index tree' (duration: 199.749397ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:41:25.974013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.859887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-03-31T18:41:25.974015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.547877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:41:25.974095Z","caller":"traceutil/trace.go:171","msg":"trace[1303488579] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8230; }","duration":"321.969018ms","start":"2026-03-31T18:41:25.652094Z","end":"2026-03-31T18:41:25.974063Z","steps":["trace[1303488579] 'range keys from in-memory index tree' (duration: 321.772965ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:41:25.974128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:41:25.652076Z","time spent":"322.04447ms","remote":"127.0.0.1:37058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-03-31T18:41:25.974119Z","caller":"traceutil/trace.go:171","msg":"trace[589066031] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:8230; }","duration":"220.650759ms","start":"2026-03-31T18:41:25.753419Z","end":"2026-03-31T18:41:25.97407Z","steps":["trace[589066031] 'count revisions from in-memory index tree' (duration: 220.492116ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:41:39.157921Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6103} {"level":"warn","ts":"2026-03-31T18:41:39.334127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.569346ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:41:39.334347Z","caller":"traceutil/trace.go:171","msg":"trace[748370794] transaction","detail":"{read_only:false; response_revision:8297; number_of_response:1; }","duration":"172.049677ms","start":"2026-03-31T18:41:39.162281Z","end":"2026-03-31T18:41:39.33433Z","steps":["trace[748370794] 'process raft request' (duration: 171.958615ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:41:39.334456Z","caller":"traceutil/trace.go:171","msg":"trace[672966420] transaction","detail":"{read_only:false; response_revision:8296; number_of_response:1; }","duration":"189.615856ms","start":"2026-03-31T18:41:39.144766Z","end":"2026-03-31T18:41:39.334382Z","steps":["trace[672966420] 'process raft request' (duration: 32.655772ms)","trace[672966420] 'compare' (duration: 87.127844ms)","trace[672966420] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; req_size:669; } (duration: 69.347331ms)"],"step_count":3} {"level":"warn","ts":"2026-03-31T18:41:39.660793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.011464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:41:39.660886Z","caller":"traceutil/trace.go:171","msg":"trace[491652993] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8298; }","duration":"174.138356ms","start":"2026-03-31T18:41:39.486728Z","end":"2026-03-31T18:41:39.660866Z","steps":["trace[491652993] 'range keys from in-memory index tree' (duration: 173.921331ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:41:39.663698Z","caller":"traceutil/trace.go:171","msg":"trace[1018453102] transaction","detail":"{read_only:false; response_revision:8300; number_of_response:1; }","duration":"102.989151ms","start":"2026-03-31T18:41:39.560689Z","end":"2026-03-31T18:41:39.663678Z","steps":["trace[1018453102] 'process raft request' (duration: 102.93503ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:41:39.663998Z","caller":"traceutil/trace.go:171","msg":"trace[1807129001] linearizableReadLoop","detail":"{readStateIndex:8594; appliedIndex:8593; }","duration":"111.663953ms","start":"2026-03-31T18:41:39.552281Z","end":"2026-03-31T18:41:39.663944Z","steps":["trace[1807129001] 'read index received' (duration: 103.563192ms)","trace[1807129001] 'applied index is now lower than readState.Index' (duration: 8.096941ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:41:39.664067Z","caller":"traceutil/trace.go:171","msg":"trace[1582564523] transaction","detail":"{read_only:false; response_revision:8299; number_of_response:1; }","duration":"123.894523ms","start":"2026-03-31T18:41:39.540101Z","end":"2026-03-31T18:41:39.663995Z","steps":["trace[1582564523] 'process raft request' (duration: 115.730201ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:41:39.664168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.886108ms","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-03-31T18:41:39.664217Z","caller":"traceutil/trace.go:171","msg":"trace[96911238] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8300; }","duration":"111.96034ms","start":"2026-03-31T18:41:39.552244Z","end":"2026-03-31T18:41:39.664205Z","steps":["trace[96911238] 'agreement among raft nodes before linearized reading' (duration: 111.813646ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:41:39.680797Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6103,"took":"520.757607ms","hash":2110240693,"current-db-size-bytes":58470400,"current-db-size":"58 MB","current-db-size-in-use-bytes":23715840,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-03-31T18:41:39.680849Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2110240693,"revision":6103,"compact-revision":3024} {"level":"warn","ts":"2026-03-31T18:42:03.083457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.336997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-mon-endpoints\" ","response":"range_response_count:1 size:389"} {"level":"info","ts":"2026-03-31T18:42:03.083587Z","caller":"traceutil/trace.go:171","msg":"trace[239784292] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-mon-endpoints; range_end:; response_count:1; response_revision:8479; }","duration":"112.54307ms","start":"2026-03-31T18:42:02.971018Z","end":"2026-03-31T18:42:03.083561Z","steps":["trace[239784292] 'range keys from in-memory index tree' (duration: 112.022341ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:42:06.388852Z","caller":"traceutil/trace.go:171","msg":"trace[1343016648] transaction","detail":"{read_only:false; response_revision:8497; number_of_response:1; }","duration":"166.693657ms","start":"2026-03-31T18:42:06.222132Z","end":"2026-03-31T18:42:06.388825Z","steps":["trace[1343016648] 'process raft request' (duration: 166.539524ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:42:06.58901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.148975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:42:06.589114Z","caller":"traceutil/trace.go:171","msg":"trace[487281703] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8497; }","duration":"102.293739ms","start":"2026-03-31T18:42:06.486799Z","end":"2026-03-31T18:42:06.589093Z","steps":["trace[487281703] 'range keys from in-memory index tree' (duration: 102.049434ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:42:09.564873Z","caller":"traceutil/trace.go:171","msg":"trace[1610522925] transaction","detail":"{read_only:false; response_revision:8511; number_of_response:1; }","duration":"139.570717ms","start":"2026-03-31T18:42:09.425279Z","end":"2026-03-31T18:42:09.56485Z","steps":["trace[1610522925] 'process raft request' (duration: 139.450415ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:42:09.596108Z","caller":"traceutil/trace.go:171","msg":"trace[539042345] linearizableReadLoop","detail":"{readStateIndex:8815; appliedIndex:8813; }","duration":"108.679908ms","start":"2026-03-31T18:42:09.487399Z","end":"2026-03-31T18:42:09.596078Z","steps":["trace[539042345] 'read index received' (duration: 77.356301ms)","trace[539042345] 'applied index is now lower than readState.Index' (duration: 31.322237ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:42:09.59614Z","caller":"traceutil/trace.go:171","msg":"trace[870573276] transaction","detail":"{read_only:false; response_revision:8512; number_of_response:1; }","duration":"170.338024ms","start":"2026-03-31T18:42:09.425779Z","end":"2026-03-31T18:42:09.596117Z","steps":["trace[870573276] 'process raft request' (duration: 170.108919ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:42:09.596229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.812011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:42:09.596274Z","caller":"traceutil/trace.go:171","msg":"trace[1901111847] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8512; }","duration":"108.895682ms","start":"2026-03-31T18:42:09.487355Z","end":"2026-03-31T18:42:09.59625Z","steps":["trace[1901111847] 'agreement among raft nodes before linearized reading' (duration: 108.82545ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:42:36.590799Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000237d.wal"} {"level":"info","ts":"2026-03-31T18:44:17.410168Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"371c7c2e52231793","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-31T18:44:17.417432Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-03-31T18:44:17.417506Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-03-31T18:46:39.166452Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8295} {"level":"info","ts":"2026-03-31T18:46:39.247786Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8295,"took":"79.469678ms","hash":2058068599,"current-db-size-bytes":58470400,"current-db-size":"58 MB","current-db-size-in-use-bytes":24944640,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-03-31T18:46:39.247867Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2058068599,"revision":8295,"compact-revision":6103} {"level":"info","ts":"2026-03-31T18:51:39.171665Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10691} {"level":"info","ts":"2026-03-31T18:51:39.245477Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10691,"took":"71.972746ms","hash":1487382805,"current-db-size-bytes":58470400,"current-db-size":"58 MB","current-db-size-in-use-bytes":20926464,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-03-31T18:51:39.245541Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1487382805,"revision":10691,"compact-revision":8295}