{"level":"warn","ts":"2026-05-19T13:36:43.907083Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-19T13:36:43.907263Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.168: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.168:2380","--initial-cluster=instance=https://199.19.213.168:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.168:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.168:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-05-19T13:36:43.907391Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-19T13:36:43.907406Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.168:2380"]}
{"level":"info","ts":"2026-05-19T13:36:43.907439Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-19T13:36:43.90827Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.168:2379"]}
{"level":"info","ts":"2026-05-19T13:36:43.908384Z","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.168:2380"],"listen-peer-urls":["https://199.19.213.168:2380"],"advertise-client-urls":["https://199.19.213.168:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.168:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.168:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-05-19T13:36:43.913704Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.986384ms"}
{"level":"info","ts":"2026-05-19T13:36:43.927157Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8ae391decac9b376","cluster-id":"d9b32c15a2c66ac"}
{"level":"info","ts":"2026-05-19T13:36:43.927338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-19T13:36:43.927383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 became follower at term 0"}
{"level":"info","ts":"2026-05-19T13:36:43.92742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8ae391decac9b376 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-19T13:36:43.927431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 became follower at term 1"}
{"level":"info","ts":"2026-05-19T13:36:43.927488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 switched to configuration voters=(10008003183018357622)"}
{"level":"warn","ts":"2026-05-19T13:36:43.936469Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-19T13:36:43.93853Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-19T13:36:43.940286Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-05-19T13:36:43.943055Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8ae391decac9b376","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-19T13:36:43.943534Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8ae391decac9b376","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-19T13:36:43.943643Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-19T13:36:43.943808Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-19T13:36:43.943857Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-19T13:36:43.945727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 switched to configuration voters=(10008003183018357622)"}
{"level":"info","ts":"2026-05-19T13:36:43.94667Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d9b32c15a2c66ac","local-member-id":"8ae391decac9b376","added-peer-id":"8ae391decac9b376","added-peer-peer-urls":["https://199.19.213.168:2380"]}
{"level":"info","ts":"2026-05-19T13:36:43.949626Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-19T13:36:43.949893Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.168:2380"}
{"level":"info","ts":"2026-05-19T13:36:43.949975Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.168:2380"}
{"level":"info","ts":"2026-05-19T13:36:43.950049Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8ae391decac9b376","initial-advertise-peer-urls":["https://199.19.213.168:2380"],"listen-peer-urls":["https://199.19.213.168:2380"],"advertise-client-urls":["https://199.19.213.168:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.168:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-19T13:36:43.950122Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-19T13:36:44.528283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-19T13:36:44.528416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-19T13:36:44.528467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 received MsgPreVoteResp from 8ae391decac9b376 at term 1"}
{"level":"info","ts":"2026-05-19T13:36:44.528509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 became candidate at term 2"}
{"level":"info","ts":"2026-05-19T13:36:44.528549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 received MsgVoteResp from 8ae391decac9b376 at term 2"}
{"level":"info","ts":"2026-05-19T13:36:44.528588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 became leader at term 2"}
{"level":"info","ts":"2026-05-19T13:36:44.528623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8ae391decac9b376 elected leader 8ae391decac9b376 at term 2"}
{"level":"info","ts":"2026-05-19T13:36:44.529897Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8ae391decac9b376","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.168:2379]}","request-path":"/0/members/8ae391decac9b376/attributes","cluster-id":"d9b32c15a2c66ac","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-19T13:36:44.529909Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-19T13:36:44.529933Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-19T13:36:44.529982Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-19T13:36:44.530312Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-19T13:36:44.530364Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-19T13:36:44.534118Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-19T13:36:44.534869Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.168:2379"}
{"level":"info","ts":"2026-05-19T13:36:44.537019Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d9b32c15a2c66ac","local-member-id":"8ae391decac9b376","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-19T13:36:44.537292Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-19T13:36:44.537388Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-19T13:37:04.889864Z","caller":"traceutil/trace.go:171","msg":"trace[407141784] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"175.680321ms","start":"2026-05-19T13:37:04.714142Z","end":"2026-05-19T13:37:04.889822Z","steps":["trace[407141784] 'process raft request'  (duration: 175.476306ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:37:10.432956Z","caller":"traceutil/trace.go:171","msg":"trace[1415881616] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"285.497417ms","start":"2026-05-19T13:37:10.14743Z","end":"2026-05-19T13:37:10.432928Z","steps":["trace[1415881616] 'process raft request'  (duration: 285.310043ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:37:10.626682Z","caller":"traceutil/trace.go:171","msg":"trace[759834448] linearizableReadLoop","detail":"{readStateIndex:483; appliedIndex:481; }","duration":"237.751959ms","start":"2026-05-19T13:37:10.388884Z","end":"2026-05-19T13:37:10.626636Z","steps":["trace[759834448] 'read index received'  (duration: 43.87177ms)","trace[759834448] 'applied index is now lower than readState.Index'  (duration: 193.878899ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:37:10.626772Z","caller":"traceutil/trace.go:171","msg":"trace[34789588] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"369.915659ms","start":"2026-05-19T13:37:10.256814Z","end":"2026-05-19T13:37:10.62673Z","steps":["trace[34789588] 'process raft request'  (duration: 363.84103ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:37:10.626869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.948344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-19T13:37:10.626959Z","caller":"traceutil/trace.go:171","msg":"trace[357192146] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:467; }","duration":"238.098477ms","start":"2026-05-19T13:37:10.388847Z","end":"2026-05-19T13:37:10.626945Z","steps":["trace[357192146] 'agreement among raft nodes before linearized reading'  (duration: 237.929323ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:37:10.627623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:37:10.25678Z","time spent":"370.114354ms","remote":"127.0.0.1:45416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:409 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-05-19T13:37:23.187709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.56687ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12931697379702053905 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:605 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-19T13:37:23.187817Z","caller":"traceutil/trace.go:171","msg":"trace[1760832759] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"437.656687ms","start":"2026-05-19T13:37:22.750144Z","end":"2026-05-19T13:37:23.187801Z","steps":["trace[1760832759] 'process raft request'  (duration: 224.78193ms)","trace[1760832759] 'compare'  (duration: 212.369466ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T13:37:23.187868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:37:22.750116Z","time spent":"437.729689ms","remote":"127.0.0.1:45416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:605 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-19T13:37:23.222433Z","caller":"traceutil/trace.go:171","msg":"trace[158905900] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:641; }","duration":"349.459168ms","start":"2026-05-19T13:37:22.87293Z","end":"2026-05-19T13:37:23.222389Z","steps":["trace[158905900] 'read index received'  (duration: 102.216141ms)","trace[158905900] 'applied index is now lower than readState.Index'  (duration: 247.242017ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:37:23.222602Z","caller":"traceutil/trace.go:171","msg":"trace[725003687] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"416.435949ms","start":"2026-05-19T13:37:22.806101Z","end":"2026-05-19T13:37:23.222537Z","steps":["trace[725003687] 'process raft request'  (duration: 416.168263ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:37:23.222777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.837117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gk984\" ","response":"range_response_count:1 size:16965"}
{"level":"warn","ts":"2026-05-19T13:37:23.222798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:37:22.806071Z","time spent":"416.639994ms","remote":"127.0.0.1:45500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:994 >> failure:<>"}
{"level":"info","ts":"2026-05-19T13:37:23.222827Z","caller":"traceutil/trace.go:171","msg":"trace[1849016940] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gk984; range_end:; response_count:1; response_revision:621; }","duration":"349.93048ms","start":"2026-05-19T13:37:22.872885Z","end":"2026-05-19T13:37:23.222816Z","steps":["trace[1849016940] 'agreement among raft nodes before linearized reading'  (duration: 349.660123ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:37:23.222851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:37:22.872863Z","time spent":"349.983011ms","remote":"127.0.0.1:45344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-gk984\" "}
{"level":"warn","ts":"2026-05-19T13:37:23.254791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.825939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-19T13:37:23.254866Z","caller":"traceutil/trace.go:171","msg":"trace[755240921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:621; }","duration":"256.936321ms","start":"2026-05-19T13:37:22.997914Z","end":"2026-05-19T13:37:23.25485Z","steps":["trace[755240921] 'agreement among raft nodes before linearized reading'  (duration: 256.718086ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:37:23.754933Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12931697379702053910,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-19T13:37:23.94239Z","caller":"traceutil/trace.go:171","msg":"trace[1611715296] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"688.539008ms","start":"2026-05-19T13:37:23.25382Z","end":"2026-05-19T13:37:23.942359Z","steps":["trace[1611715296] 'process raft request'  (duration: 688.260542ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:37:23.942706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:37:23.253799Z","time spent":"688.775793ms","remote":"127.0.0.1:45344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-gk984\" mod_revision:505 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-gk984\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-gk984\" > >"}
{"level":"info","ts":"2026-05-19T13:37:23.976193Z","caller":"traceutil/trace.go:171","msg":"trace[1483824106] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:644; }","duration":"721.800383ms","start":"2026-05-19T13:37:23.254365Z","end":"2026-05-19T13:37:23.976165Z","steps":["trace[1483824106] 'read index received'  (duration: 687.757649ms)","trace[1483824106] 'applied index is now lower than readState.Index'  (duration: 34.041603ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:37:23.976274Z","caller":"traceutil/trace.go:171","msg":"trace[2144273560] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"713.545743ms","start":"2026-05-19T13:37:23.262694Z","end":"2026-05-19T13:37:23.97624Z","steps":["trace[2144273560] 'process raft request'  (duration: 713.330058ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:37:23.976432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.63728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T13:37:23.977027Z","caller":"traceutil/trace.go:171","msg":"trace[1861412078] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:623; }","duration":"735.289345ms","start":"2026-05-19T13:37:23.241726Z","end":"2026-05-19T13:37:23.977016Z","steps":["trace[1861412078] 'agreement among raft nodes before linearized reading'  (duration: 734.563757ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:37:23.977058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:37:23.241703Z","time spent":"735.347816ms","remote":"127.0.0.1:45622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "}
{"level":"warn","ts":"2026-05-19T13:37:23.976474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:37:23.262621Z","time spent":"713.778669ms","remote":"127.0.0.1:45416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:607 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-05-19T13:37:23.97654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.816409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T13:37:23.977177Z","caller":"traceutil/trace.go:171","msg":"trace[593849721] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:623; }","duration":"164.496234ms","start":"2026-05-19T13:37:23.812673Z","end":"2026-05-19T13:37:23.977169Z","steps":["trace[593849721] 'agreement among raft nodes before linearized reading'  (duration: 163.815559ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:37:23.976594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.991853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T13:37:23.977272Z","caller":"traceutil/trace.go:171","msg":"trace[2144229716] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:623; }","duration":"164.734209ms","start":"2026-05-19T13:37:23.812533Z","end":"2026-05-19T13:37:23.977267Z","steps":["trace[2144229716] 'agreement among raft nodes before linearized reading'  (duration: 163.989553ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:37:23.976561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.735246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-19T13:37:23.976663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.010163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T13:37:23.977588Z","caller":"traceutil/trace.go:171","msg":"trace[1946203724] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:623; }","duration":"164.989895ms","start":"2026-05-19T13:37:23.812586Z","end":"2026-05-19T13:37:23.977576Z","steps":["trace[1946203724] 'agreement among raft nodes before linearized reading'  (duration: 163.974332ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:37:23.97691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.384641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-19T13:37:23.977687Z","caller":"traceutil/trace.go:171","msg":"trace[543285276] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:623; }","duration":"368.239211ms","start":"2026-05-19T13:37:23.609441Z","end":"2026-05-19T13:37:23.97768Z","steps":["trace[543285276] 'agreement among raft nodes before linearized reading'  (duration: 367.194177ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:37:23.977712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:37:23.609416Z","time spent":"368.287171ms","remote":"127.0.0.1:45416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-19T13:37:23.977981Z","caller":"traceutil/trace.go:171","msg":"trace[1246960254] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"673.609226ms","start":"2026-05-19T13:37:23.303738Z","end":"2026-05-19T13:37:23.977348Z","steps":["trace[1246960254] 'agreement among raft nodes before linearized reading'  (duration: 672.697586ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:37:23.978057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:37:23.303716Z","time spent":"674.322312ms","remote":"127.0.0.1:58630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-19T13:37:25.148445Z","caller":"traceutil/trace.go:171","msg":"trace[236857011] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"156.879069ms","start":"2026-05-19T13:37:24.991524Z","end":"2026-05-19T13:37:25.148403Z","steps":["trace[236857011] 'process raft request'  (duration: 156.631833ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:37:25.148495Z","caller":"traceutil/trace.go:171","msg":"trace[231452318] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"156.846397ms","start":"2026-05-19T13:37:24.991601Z","end":"2026-05-19T13:37:25.148447Z","steps":["trace[231452318] 'process raft request'  (duration: 156.693454ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:37:25.148537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.293791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T13:37:25.148616Z","caller":"traceutil/trace.go:171","msg":"trace[114296677] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:638; }","duration":"118.441554ms","start":"2026-05-19T13:37:25.030162Z","end":"2026-05-19T13:37:25.148604Z","steps":["trace[114296677] 'agreement among raft nodes before linearized reading'  (duration: 118.295301ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:37:25.14845Z","caller":"traceutil/trace.go:171","msg":"trace[184482301] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:658; }","duration":"118.196259ms","start":"2026-05-19T13:37:25.030224Z","end":"2026-05-19T13:37:25.14842Z","steps":["trace[184482301] 'read index received'  (duration: 117.910602ms)","trace[184482301] 'applied index is now lower than readState.Index'  (duration: 284.297µs)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:37:25.148843Z","caller":"traceutil/trace.go:171","msg":"trace[1912636837] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"155.307342ms","start":"2026-05-19T13:37:24.993522Z","end":"2026-05-19T13:37:25.148829Z","steps":["trace[1912636837] 'process raft request'  (duration: 154.839762ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:37:25.148915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.600587ms","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-05-19T13:37:25.148967Z","caller":"traceutil/trace.go:171","msg":"trace[982935815] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:638; }","duration":"118.710631ms","start":"2026-05-19T13:37:25.030231Z","end":"2026-05-19T13:37:25.148942Z","steps":["trace[982935815] 'agreement among raft nodes before linearized reading'  (duration: 118.605778ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:37:40.588647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.22945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T13:37:40.588774Z","caller":"traceutil/trace.go:171","msg":"trace[1694821628] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:792; }","duration":"284.405553ms","start":"2026-05-19T13:37:40.304349Z","end":"2026-05-19T13:37:40.588754Z","steps":["trace[1694821628] 'range keys from in-memory index tree'  (duration: 284.129837ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:38:29.948662Z","caller":"traceutil/trace.go:171","msg":"trace[992441011] transaction","detail":"{read_only:false; response_revision:1394; number_of_response:1; }","duration":"103.413199ms","start":"2026-05-19T13:38:29.845186Z","end":"2026-05-19T13:38:29.948599Z","steps":["trace[992441011] 'process raft request'  (duration: 59.124447ms)","trace[992441011] 'compare'  (duration: 43.936694ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:38:29.94887Z","caller":"traceutil/trace.go:171","msg":"trace[824269534] transaction","detail":"{read_only:false; response_revision:1395; number_of_response:1; }","duration":"101.257452ms","start":"2026-05-19T13:38:29.84757Z","end":"2026-05-19T13:38:29.948827Z","steps":["trace[824269534] 'process raft request'  (duration: 100.924583ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:38:30.202783Z","caller":"traceutil/trace.go:171","msg":"trace[1040314048] transaction","detail":"{read_only:false; response_revision:1404; number_of_response:1; }","duration":"206.488302ms","start":"2026-05-19T13:38:29.996246Z","end":"2026-05-19T13:38:30.202734Z","steps":["trace[1040314048] 'process raft request'  (duration: 133.776681ms)","trace[1040314048] 'compare'  (duration: 72.401374ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:38:30.20276Z","caller":"traceutil/trace.go:171","msg":"trace[493478854] linearizableReadLoop","detail":"{readStateIndex:1448; appliedIndex:1447; }","duration":"183.51506ms","start":"2026-05-19T13:38:30.019195Z","end":"2026-05-19T13:38:30.20271Z","steps":["trace[493478854] 'read index received'  (duration: 110.760239ms)","trace[493478854] 'applied index is now lower than readState.Index'  (duration: 72.753411ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T13:38:30.203282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.325203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-controller-bnx5v\" ","response":"range_response_count:1 size:6053"}
{"level":"info","ts":"2026-05-19T13:38:30.203333Z","caller":"traceutil/trace.go:171","msg":"trace[2010936749] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-controller-bnx5v; range_end:; response_count:1; response_revision:1404; }","duration":"246.400454ms","start":"2026-05-19T13:38:29.956915Z","end":"2026-05-19T13:38:30.203316Z","steps":["trace[2010936749] 'agreement among raft nodes before linearized reading'  (duration: 245.933163ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:38:30.203454Z","caller":"traceutil/trace.go:171","msg":"trace[1739484760] transaction","detail":"{read_only:false; response_revision:1407; number_of_response:1; }","duration":"175.188719ms","start":"2026-05-19T13:38:30.028246Z","end":"2026-05-19T13:38:30.203435Z","steps":["trace[1739484760] 'process raft request'  (duration: 174.954334ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:38:30.20349Z","caller":"traceutil/trace.go:171","msg":"trace[639069535] transaction","detail":"{read_only:false; response_revision:1405; number_of_response:1; }","duration":"178.75707ms","start":"2026-05-19T13:38:30.024599Z","end":"2026-05-19T13:38:30.203356Z","steps":["trace[639069535] 'process raft request'  (duration: 178.066774ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:38:30.203723Z","caller":"traceutil/trace.go:171","msg":"trace[2057369267] transaction","detail":"{read_only:false; response_revision:1406; number_of_response:1; }","duration":"176.459058ms","start":"2026-05-19T13:38:30.027216Z","end":"2026-05-19T13:38:30.203675Z","steps":["trace[2057369267] 'process raft request'  (duration: 175.919455ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:38:30.378924Z","caller":"traceutil/trace.go:171","msg":"trace[208131113] transaction","detail":"{read_only:false; response_revision:1411; number_of_response:1; }","duration":"118.652342ms","start":"2026-05-19T13:38:30.260236Z","end":"2026-05-19T13:38:30.378888Z","steps":["trace[208131113] 'process raft request'  (duration: 46.32141ms)","trace[208131113] 'compare'  (duration: 72.018355ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:38:30.37923Z","caller":"traceutil/trace.go:171","msg":"trace[151499915] transaction","detail":"{read_only:false; response_revision:1413; number_of_response:1; }","duration":"117.458305ms","start":"2026-05-19T13:38:30.261735Z","end":"2026-05-19T13:38:30.379193Z","steps":["trace[151499915] 'process raft request'  (duration: 117.089616ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:38:30.378922Z","caller":"traceutil/trace.go:171","msg":"trace[1285264060] transaction","detail":"{read_only:false; response_revision:1412; number_of_response:1; }","duration":"117.24687ms","start":"2026-05-19T13:38:30.261639Z","end":"2026-05-19T13:38:30.378886Z","steps":["trace[1285264060] 'process raft request'  (duration: 117.111847ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:38:30.37955Z","caller":"traceutil/trace.go:171","msg":"trace[440411707] transaction","detail":"{read_only:false; response_revision:1414; number_of_response:1; }","duration":"117.775641ms","start":"2026-05-19T13:38:30.261753Z","end":"2026-05-19T13:38:30.379529Z","steps":["trace[440411707] 'process raft request'  (duration: 117.326421ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:38:30.380207Z","caller":"traceutil/trace.go:171","msg":"trace[424594575] transaction","detail":"{read_only:false; response_revision:1415; number_of_response:1; }","duration":"118.326315ms","start":"2026-05-19T13:38:30.261863Z","end":"2026-05-19T13:38:30.380189Z","steps":["trace[424594575] 'process raft request'  (duration: 117.548687ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:38:30.380629Z","caller":"traceutil/trace.go:171","msg":"trace[1332307852] transaction","detail":"{read_only:false; response_revision:1416; number_of_response:1; }","duration":"118.52429ms","start":"2026-05-19T13:38:30.262089Z","end":"2026-05-19T13:38:30.380613Z","steps":["trace[1332307852] 'process raft request'  (duration: 118.015408ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:38:31.381599Z","caller":"traceutil/trace.go:171","msg":"trace[2043978091] linearizableReadLoop","detail":"{readStateIndex:1485; appliedIndex:1484; }","duration":"110.818382ms","start":"2026-05-19T13:38:31.270756Z","end":"2026-05-19T13:38:31.381574Z","steps":["trace[2043978091] 'read index received'  (duration: 110.775351ms)","trace[2043978091] 'applied index is now lower than readState.Index'  (duration: 42.161µs)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:38:31.381772Z","caller":"traceutil/trace.go:171","msg":"trace[1654465934] transaction","detail":"{read_only:false; response_revision:1441; number_of_response:1; }","duration":"125.343467ms","start":"2026-05-19T13:38:31.25642Z","end":"2026-05-19T13:38:31.381763Z","steps":["trace[1654465934] 'process raft request'  (duration: 125.02189ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:38:31.382119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.337443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"}
{"level":"info","ts":"2026-05-19T13:38:31.38223Z","caller":"traceutil/trace.go:171","msg":"trace[1883019673] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1441; }","duration":"111.453896ms","start":"2026-05-19T13:38:31.270748Z","end":"2026-05-19T13:38:31.382202Z","steps":["trace[1883019673] 'agreement among raft nodes before linearized reading'  (duration: 111.106808ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:38:31.425523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.475861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T13:38:31.42563Z","caller":"traceutil/trace.go:171","msg":"trace[362678692] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1442; }","duration":"122.605273ms","start":"2026-05-19T13:38:31.302987Z","end":"2026-05-19T13:38:31.425592Z","steps":["trace[362678692] 'agreement among raft nodes before linearized reading'  (duration: 122.347988ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:38:33.648251Z","caller":"traceutil/trace.go:171","msg":"trace[2003833541] transaction","detail":"{read_only:false; response_revision:1457; number_of_response:1; }","duration":"217.392853ms","start":"2026-05-19T13:38:33.430822Z","end":"2026-05-19T13:38:33.648215Z","steps":["trace[2003833541] 'process raft request'  (duration: 217.126177ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:38:45.456155Z","caller":"traceutil/trace.go:171","msg":"trace[20273839] transaction","detail":"{read_only:false; response_revision:1663; number_of_response:1; }","duration":"120.811102ms","start":"2026-05-19T13:38:45.335301Z","end":"2026-05-19T13:38:45.456112Z","steps":["trace[20273839] 'process raft request'  (duration: 120.553566ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:38:45.45633Z","caller":"traceutil/trace.go:171","msg":"trace[864846069] transaction","detail":"{read_only:false; response_revision:1664; number_of_response:1; }","duration":"118.086918ms","start":"2026-05-19T13:38:45.338186Z","end":"2026-05-19T13:38:45.456273Z","steps":["trace[864846069] 'process raft request'  (duration: 117.830092ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:38:45.50563Z","caller":"traceutil/trace.go:171","msg":"trace[1232763664] transaction","detail":"{read_only:false; response_revision:1666; number_of_response:1; }","duration":"126.862581ms","start":"2026-05-19T13:38:45.378743Z","end":"2026-05-19T13:38:45.505605Z","steps":["trace[1232763664] 'process raft request'  (duration: 126.754849ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:38:49.782181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.91329ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12931697379702056042 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/cilium.io/ciliumendpoints/openstack/pxc-operator-59d66cbc78-8gp6n\" mod_revision:0 > success:<request_put:<key:\"/registry/cilium.io/ciliumendpoints/openstack/pxc-operator-59d66cbc78-8gp6n\" value_size:2575 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-19T13:38:49.7823Z","caller":"traceutil/trace.go:171","msg":"trace[466917061] transaction","detail":"{read_only:false; response_revision:1726; number_of_response:1; }","duration":"146.014735ms","start":"2026-05-19T13:38:49.636265Z","end":"2026-05-19T13:38:49.78228Z","steps":["trace[466917061] 'process raft request'  (duration: 35.91692ms)","trace[466917061] 'compare'  (duration: 109.694125ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T13:38:55.765424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.258815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T13:38:55.765553Z","caller":"traceutil/trace.go:171","msg":"trace[982974072] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1843; }","duration":"167.526611ms","start":"2026-05-19T13:38:55.598Z","end":"2026-05-19T13:38:55.765526Z","steps":["trace[982974072] 'count revisions from in-memory index tree'  (duration: 167.087091ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:38:56.24593Z","caller":"traceutil/trace.go:171","msg":"trace[1633089637] linearizableReadLoop","detail":"{readStateIndex:1900; appliedIndex:1899; }","duration":"431.85971ms","start":"2026-05-19T13:38:55.814023Z","end":"2026-05-19T13:38:56.245883Z","steps":["trace[1633089637] 'read index received'  (duration: 431.547193ms)","trace[1633089637] 'applied index is now lower than readState.Index'  (duration: 311.677µs)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:38:56.246041Z","caller":"traceutil/trace.go:171","msg":"trace[1435815282] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"435.224729ms","start":"2026-05-19T13:38:55.810774Z","end":"2026-05-19T13:38:56.245998Z","steps":["trace[1435815282] 'process raft request'  (duration: 434.85411ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:38:56.246203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.163017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-05-19T13:38:56.246208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.565244ms","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-05-19T13:38:56.246247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:38:55.810742Z","time spent":"435.396453ms","remote":"127.0.0.1:45416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1775 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-19T13:38:56.246305Z","caller":"traceutil/trace.go:171","msg":"trace[1347678651] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1844; }","duration":"309.713457ms","start":"2026-05-19T13:38:55.936577Z","end":"2026-05-19T13:38:56.24629Z","steps":["trace[1347678651] 'agreement among raft nodes before linearized reading'  (duration: 309.515103ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:38:56.246243Z","caller":"traceutil/trace.go:171","msg":"trace[1091836917] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1844; }","duration":"432.263019ms","start":"2026-05-19T13:38:55.813968Z","end":"2026-05-19T13:38:56.246231Z","steps":["trace[1091836917] 'agreement among raft nodes before linearized reading'  (duration: 432.089345ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:38:56.246389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:38:55.936551Z","time spent":"309.82591ms","remote":"127.0.0.1:45416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-19T13:38:56.246539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:38:55.813946Z","time spent":"432.523566ms","remote":"127.0.0.1:45416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-19T13:38:56.443376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.878146ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12931697379702056289 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1776 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-19T13:38:56.443651Z","caller":"traceutil/trace.go:171","msg":"trace[1673448414] linearizableReadLoop","detail":"{readStateIndex:1902; appliedIndex:1900; }","duration":"189.633102ms","start":"2026-05-19T13:38:56.253993Z","end":"2026-05-19T13:38:56.443626Z","steps":["trace[1673448414] 'read index received'  (duration: 32.408029ms)","trace[1673448414] 'applied index is now lower than readState.Index'  (duration: 157.223643ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:38:56.443726Z","caller":"traceutil/trace.go:171","msg":"trace[810903877] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"192.681592ms","start":"2026-05-19T13:38:56.250979Z","end":"2026-05-19T13:38:56.443661Z","steps":["trace[810903877] 'process raft request'  (duration: 35.348996ms)","trace[810903877] 'compare'  (duration: 156.63161ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T13:38:56.443907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.93632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T13:38:56.44397Z","caller":"traceutil/trace.go:171","msg":"trace[1676233166] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1846; }","duration":"139.059873ms","start":"2026-05-19T13:38:56.304897Z","end":"2026-05-19T13:38:56.443956Z","steps":["trace[1676233166] 'agreement among raft nodes before linearized reading'  (duration: 138.94334ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:38:56.443752Z","caller":"traceutil/trace.go:171","msg":"trace[181054531] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"192.684962ms","start":"2026-05-19T13:38:56.251015Z","end":"2026-05-19T13:38:56.4437Z","steps":["trace[181054531] 'process raft request'  (duration: 192.517078ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:38:56.443964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.96856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9375da7b-a944-4d27-a37f-8991f3510663\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-05-19T13:38:56.444173Z","caller":"traceutil/trace.go:171","msg":"trace[1407047038] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9375da7b-a944-4d27-a37f-8991f3510663; range_end:; response_count:1; response_revision:1846; }","duration":"190.185586ms","start":"2026-05-19T13:38:56.253939Z","end":"2026-05-19T13:38:56.444124Z","steps":["trace[1407047038] 'agreement among raft nodes before linearized reading'  (duration: 189.854847ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:39:33.849028Z","caller":"traceutil/trace.go:171","msg":"trace[1971490731] linearizableReadLoop","detail":"{readStateIndex:2225; appliedIndex:2224; }","duration":"122.320815ms","start":"2026-05-19T13:39:33.726673Z","end":"2026-05-19T13:39:33.848993Z","steps":["trace[1971490731] 'read index received'  (duration: 118.921781ms)","trace[1971490731] 'applied index is now lower than readState.Index'  (duration: 3.397424ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:39:33.849079Z","caller":"traceutil/trace.go:171","msg":"trace[1831015599] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"145.205487ms","start":"2026-05-19T13:39:33.703845Z","end":"2026-05-19T13:39:33.849051Z","steps":["trace[1831015599] 'process raft request'  (duration: 141.800713ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:39:33.849347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.635732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:525"}
{"level":"info","ts":"2026-05-19T13:39:33.849477Z","caller":"traceutil/trace.go:171","msg":"trace[1679722307] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:2153; }","duration":"122.819956ms","start":"2026-05-19T13:39:33.726639Z","end":"2026-05-19T13:39:33.849459Z","steps":["trace[1679722307] 'agreement among raft nodes before linearized reading'  (duration: 122.489229ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:39:39.712647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.429978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b0fb1e1abe5c27\" ","response":"range_response_count:1 size:846"}
{"level":"info","ts":"2026-05-19T13:39:39.712754Z","caller":"traceutil/trace.go:171","msg":"trace[1661140552] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18b0fb1e1abe5c27; range_end:; response_count:1; response_revision:2187; }","duration":"184.583792ms","start":"2026-05-19T13:39:39.528146Z","end":"2026-05-19T13:39:39.71273Z","steps":["trace[1661140552] 'range keys from in-memory index tree'  (duration: 184.262135ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:39:39.864717Z","caller":"traceutil/trace.go:171","msg":"trace[1025259922] linearizableReadLoop","detail":"{readStateIndex:2262; appliedIndex:2261; }","duration":"148.444628ms","start":"2026-05-19T13:39:39.716242Z","end":"2026-05-19T13:39:39.864687Z","steps":["trace[1025259922] 'read index received'  (duration: 148.205863ms)","trace[1025259922] 'applied index is now lower than readState.Index'  (duration: 237.555µs)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:39:39.864739Z","caller":"traceutil/trace.go:171","msg":"trace[1942091540] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"149.576112ms","start":"2026-05-19T13:39:39.715138Z","end":"2026-05-19T13:39:39.864714Z","steps":["trace[1942091540] 'process raft request'  (duration: 149.384008ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:39:39.864973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.724924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:567"}
{"level":"info","ts":"2026-05-19T13:39:39.865024Z","caller":"traceutil/trace.go:171","msg":"trace[19015699] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2188; }","duration":"148.839937ms","start":"2026-05-19T13:39:39.716169Z","end":"2026-05-19T13:39:39.865009Z","steps":["trace[19015699] 'agreement among raft nodes before linearized reading'  (duration: 148.620532ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:39:39.865338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.976618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T13:39:39.865527Z","caller":"traceutil/trace.go:171","msg":"trace[361865297] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:2188; }","duration":"138.223265ms","start":"2026-05-19T13:39:39.727236Z","end":"2026-05-19T13:39:39.865459Z","steps":["trace[361865297] 'agreement among raft nodes before linearized reading'  (duration: 137.949858ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:39:40.036277Z","caller":"traceutil/trace.go:171","msg":"trace[1639690749] linearizableReadLoop","detail":"{readStateIndex:2263; appliedIndex:2262; }","duration":"159.063622ms","start":"2026-05-19T13:39:39.877183Z","end":"2026-05-19T13:39:40.036247Z","steps":["trace[1639690749] 'read index received'  (duration: 150.076833ms)","trace[1639690749] 'applied index is now lower than readState.Index'  (duration: 8.985489ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:39:40.036383Z","caller":"traceutil/trace.go:171","msg":"trace[1466305480] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"166.72527ms","start":"2026-05-19T13:39:39.8696Z","end":"2026-05-19T13:39:40.036325Z","steps":["trace[1466305480] 'process raft request'  (duration: 157.730992ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:39:40.03655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.900611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"}
{"level":"warn","ts":"2026-05-19T13:39:40.03651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.308327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:525"}
{"level":"info","ts":"2026-05-19T13:39:40.036739Z","caller":"traceutil/trace.go:171","msg":"trace[906692440] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:2189; }","duration":"159.580693ms","start":"2026-05-19T13:39:39.877135Z","end":"2026-05-19T13:39:40.036715Z","steps":["trace[906692440] 'agreement among raft nodes before linearized reading'  (duration: 159.203215ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:39:40.036632Z","caller":"traceutil/trace.go:171","msg":"trace[2131716558] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2189; }","duration":"145.031844ms","start":"2026-05-19T13:39:39.891574Z","end":"2026-05-19T13:39:40.036606Z","steps":["trace[2131716558] 'agreement among raft nodes before linearized reading'  (duration: 144.820139ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:39:40.221732Z","caller":"traceutil/trace.go:171","msg":"trace[2032382596] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"179.305766ms","start":"2026-05-19T13:39:40.04239Z","end":"2026-05-19T13:39:40.221696Z","steps":["trace[2032382596] 'process raft request'  (duration: 98.355489ms)","trace[2032382596] 'compare'  (duration: 80.698782ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:39:40.221835Z","caller":"traceutil/trace.go:171","msg":"trace[604717049] linearizableReadLoop","detail":"{readStateIndex:2266; appliedIndex:2264; }","duration":"113.593714ms","start":"2026-05-19T13:39:40.108225Z","end":"2026-05-19T13:39:40.221818Z","steps":["trace[604717049] 'read index received'  (duration: 32.492653ms)","trace[604717049] 'applied index is now lower than readState.Index'  (duration: 81.100081ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T13:39:40.222133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.898081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"}
{"level":"info","ts":"2026-05-19T13:39:40.222177Z","caller":"traceutil/trace.go:171","msg":"trace[266001166] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2192; }","duration":"113.957882ms","start":"2026-05-19T13:39:40.108207Z","end":"2026-05-19T13:39:40.222164Z","steps":["trace[266001166] 'agreement among raft nodes before linearized reading'  (duration: 113.730887ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:39:40.222269Z","caller":"traceutil/trace.go:171","msg":"trace[1486096075] transaction","detail":"{read_only:false; response_revision:2192; number_of_response:1; }","duration":"177.713291ms","start":"2026-05-19T13:39:40.044441Z","end":"2026-05-19T13:39:40.222154Z","steps":["trace[1486096075] 'process raft request'  (duration: 177.158519ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:40:16.20828Z","caller":"traceutil/trace.go:171","msg":"trace[1129419424] transaction","detail":"{read_only:false; response_revision:2488; number_of_response:1; }","duration":"101.592873ms","start":"2026-05-19T13:40:16.106648Z","end":"2026-05-19T13:40:16.208241Z","steps":["trace[1129419424] 'process raft request'  (duration: 101.279106ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:40:46.960394Z","caller":"traceutil/trace.go:171","msg":"trace[1696498179] transaction","detail":"{read_only:false; response_revision:2700; number_of_response:1; }","duration":"122.542837ms","start":"2026-05-19T13:40:46.837187Z","end":"2026-05-19T13:40:46.95973Z","steps":["trace[1696498179] 'process raft request'  (duration: 122.336152ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:40:52.420334Z","caller":"traceutil/trace.go:171","msg":"trace[941275560] transaction","detail":"{read_only:false; response_revision:2738; number_of_response:1; }","duration":"252.317167ms","start":"2026-05-19T13:40:52.167978Z","end":"2026-05-19T13:40:52.420295Z","steps":["trace[941275560] 'process raft request'  (duration: 252.084282ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:40:52.604549Z","caller":"traceutil/trace.go:171","msg":"trace[293298666] transaction","detail":"{read_only:false; number_of_response:0; response_revision:2738; }","duration":"176.514868ms","start":"2026-05-19T13:40:52.427989Z","end":"2026-05-19T13:40:52.604504Z","steps":["trace[293298666] 'process raft request'  (duration: 176.374055ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:42:14.874852Z","caller":"traceutil/trace.go:171","msg":"trace[1335428855] transaction","detail":"{read_only:false; response_revision:3455; number_of_response:1; }","duration":"150.331666ms","start":"2026-05-19T13:42:14.724484Z","end":"2026-05-19T13:42:14.874816Z","steps":["trace[1335428855] 'process raft request'  (duration: 150.149431ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:42:40.641344Z","caller":"traceutil/trace.go:171","msg":"trace[1669072260] transaction","detail":"{read_only:false; number_of_response:0; response_revision:3636; }","duration":"111.08608ms","start":"2026-05-19T13:42:40.530219Z","end":"2026-05-19T13:42:40.641305Z","steps":["trace[1669072260] 'process raft request'  (duration: 105.512572ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:43:47.522523Z","caller":"traceutil/trace.go:171","msg":"trace[309664356] transaction","detail":"{read_only:false; response_revision:4778; number_of_response:1; }","duration":"224.877839ms","start":"2026-05-19T13:43:47.297613Z","end":"2026-05-19T13:43:47.522491Z","steps":["trace[309664356] 'process raft request'  (duration: 224.681915ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:43:47.58168Z","caller":"traceutil/trace.go:171","msg":"trace[2065903174] linearizableReadLoop","detail":"{readStateIndex:4988; appliedIndex:4986; }","duration":"230.205691ms","start":"2026-05-19T13:43:47.351442Z","end":"2026-05-19T13:43:47.581648Z","steps":["trace[2065903174] 'read index received'  (duration: 170.937299ms)","trace[2065903174] 'applied index is now lower than readState.Index'  (duration: 59.266762ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:43:47.581797Z","caller":"traceutil/trace.go:171","msg":"trace[1066257341] transaction","detail":"{read_only:false; response_revision:4779; number_of_response:1; }","duration":"240.054058ms","start":"2026-05-19T13:43:47.341708Z","end":"2026-05-19T13:43:47.581762Z","steps":["trace[1066257341] 'process raft request'  (duration: 239.777772ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:43:47.581925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.459178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5hww9\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-05-19T13:43:47.581963Z","caller":"traceutil/trace.go:171","msg":"trace[883412866] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5hww9; range_end:; response_count:1; response_revision:4779; }","duration":"230.556619ms","start":"2026-05-19T13:43:47.351395Z","end":"2026-05-19T13:43:47.581952Z","steps":["trace[883412866] 'agreement among raft nodes before linearized reading'  (duration: 230.386885ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:43:47.656991Z","caller":"traceutil/trace.go:171","msg":"trace[1469535129] transaction","detail":"{read_only:false; number_of_response:0; response_revision:4779; }","duration":"126.356935ms","start":"2026-05-19T13:43:47.530603Z","end":"2026-05-19T13:43:47.656959Z","steps":["trace[1469535129] 'process raft request'  (duration: 126.16381ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:43:47.657217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.344367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f708af92-a0b7-401f-a74e-175e6328aed7\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-05-19T13:43:47.65731Z","caller":"traceutil/trace.go:171","msg":"trace[740420622] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f708af92-a0b7-401f-a74e-175e6328aed7; range_end:; response_count:1; response_revision:4779; }","duration":"291.46761ms","start":"2026-05-19T13:43:47.365818Z","end":"2026-05-19T13:43:47.657286Z","steps":["trace[740420622] 'agreement among raft nodes before linearized reading'  (duration: 291.181104ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:43:47.657387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.593458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"}
{"level":"info","ts":"2026-05-19T13:43:47.657471Z","caller":"traceutil/trace.go:171","msg":"trace[1072760598] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:4779; }","duration":"149.742262ms","start":"2026-05-19T13:43:47.507707Z","end":"2026-05-19T13:43:47.65745Z","steps":["trace[1072760598] 'agreement among raft nodes before linearized reading'  (duration: 149.443705ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:44:00.140188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.467738ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12931697379702064208 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/endpointslices/openstack/memcached-metrics-89lhn\" mod_revision:0 > success:<request_put:<key:\"/registry/endpointslices/openstack/memcached-metrics-89lhn\" value_size:939 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-19T13:44:00.140546Z","caller":"traceutil/trace.go:171","msg":"trace[240112357] linearizableReadLoop","detail":"{readStateIndex:5244; appliedIndex:5241; }","duration":"185.3441ms","start":"2026-05-19T13:43:59.95509Z","end":"2026-05-19T13:44:00.140434Z","steps":["trace[240112357] 'read index received'  (duration: 34.658527ms)","trace[240112357] 'applied index is now lower than readState.Index'  (duration: 150.684493ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T13:44:00.140752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.658218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-c47d949f5-jp646\" ","response":"range_response_count:1 size:7813"}
{"level":"info","ts":"2026-05-19T13:44:00.140792Z","caller":"traceutil/trace.go:171","msg":"trace[840181296] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-c47d949f5-jp646; range_end:; response_count:1; response_revision:5025; }","duration":"185.74003ms","start":"2026-05-19T13:43:59.955039Z","end":"2026-05-19T13:44:00.140779Z","steps":["trace[840181296] 'agreement among raft nodes before linearized reading'  (duration: 185.556335ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:44:00.141004Z","caller":"traceutil/trace.go:171","msg":"trace[320931704] transaction","detail":"{read_only:false; response_revision:5024; number_of_response:1; }","duration":"335.263547ms","start":"2026-05-19T13:43:59.805675Z","end":"2026-05-19T13:44:00.140939Z","steps":["trace[320931704] 'process raft request'  (duration: 334.628162ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:44:00.141087Z","caller":"traceutil/trace.go:171","msg":"trace[819481179] transaction","detail":"{read_only:false; response_revision:5023; number_of_response:1; }","duration":"337.579441ms","start":"2026-05-19T13:43:59.803464Z","end":"2026-05-19T13:44:00.141044Z","steps":["trace[819481179] 'process raft request'  (duration: 186.17585ms)","trace[819481179] 'compare'  (duration: 150.273014ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:44:00.141161Z","caller":"traceutil/trace.go:171","msg":"trace[1299106087] transaction","detail":"{read_only:false; response_revision:5025; number_of_response:1; }","duration":"304.51316ms","start":"2026-05-19T13:43:59.836606Z","end":"2026-05-19T13:44:00.141119Z","steps":["trace[1299106087] 'process raft request'  (duration: 303.767832ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:44:00.141276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:43:59.8034Z","time spent":"337.793445ms","remote":"127.0.0.1:45424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1005,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/memcached-metrics-89lhn\" mod_revision:0 > success:<request_put:<key:\"/registry/endpointslices/openstack/memcached-metrics-89lhn\" value_size:939 >> failure:<>"}
{"level":"warn","ts":"2026-05-19T13:44:00.141349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:43:59.836583Z","time spent":"304.666233ms","remote":"127.0.0.1:58698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":891,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-l7jlv.18b0fb5b65a10343\" mod_revision:4647 > success:<request_put:<key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-l7jlv.18b0fb5b65a10343\" value_size:776 lease:3708325342847286451 >> failure:<request_range:<key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-l7jlv.18b0fb5b65a10343\" > >"}
{"level":"warn","ts":"2026-05-19T13:44:00.141195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:43:59.805647Z","time spent":"335.449821ms","remote":"127.0.0.1:45332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":524,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/memcached-metrics\" mod_revision:0 > success:<request_put:<key:\"/registry/services/endpoints/openstack/memcached-metrics\" value_size:460 >> failure:<>"}
{"level":"info","ts":"2026-05-19T13:44:00.372914Z","caller":"traceutil/trace.go:171","msg":"trace[1147806735] linearizableReadLoop","detail":"{readStateIndex:5245; appliedIndex:5244; }","duration":"218.633865ms","start":"2026-05-19T13:44:00.154247Z","end":"2026-05-19T13:44:00.372881Z","steps":["trace[1147806735] 'read index received'  (duration: 124.810119ms)","trace[1147806735] 'applied index is now lower than readState.Index'  (duration: 93.822576ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T13:44:00.373183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.07791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-19T13:44:00.373226Z","caller":"traceutil/trace.go:171","msg":"trace[996433447] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5026; }","duration":"167.167312ms","start":"2026-05-19T13:44:00.206046Z","end":"2026-05-19T13:44:00.373213Z","steps":["trace[996433447] 'agreement among raft nodes before linearized reading'  (duration: 167.000158ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:44:00.373045Z","caller":"traceutil/trace.go:171","msg":"trace[337183388] transaction","detail":"{read_only:false; response_revision:5026; number_of_response:1; }","duration":"221.593544ms","start":"2026-05-19T13:44:00.151412Z","end":"2026-05-19T13:44:00.373005Z","steps":["trace[337183388] 'process raft request'  (duration: 127.653265ms)","trace[337183388] 'compare'  (duration: 93.667053ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T13:44:00.373257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.991254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-19T13:44:00.373339Z","caller":"traceutil/trace.go:171","msg":"trace[2134128378] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5026; }","duration":"219.117077ms","start":"2026-05-19T13:44:00.1542Z","end":"2026-05-19T13:44:00.373317Z","steps":["trace[2134128378] 'agreement among raft nodes before linearized reading'  (duration: 218.80721ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:44:00.373539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.09778ms","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-05-19T13:44:00.373608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.153251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-19T13:44:00.373641Z","caller":"traceutil/trace.go:171","msg":"trace[594891381] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5026; }","duration":"153.243563ms","start":"2026-05-19T13:44:00.220374Z","end":"2026-05-19T13:44:00.373618Z","steps":["trace[594891381] 'agreement among raft nodes before linearized reading'  (duration: 153.032237ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:44:00.373677Z","caller":"traceutil/trace.go:171","msg":"trace[1256527883] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5026; }","duration":"153.874867ms","start":"2026-05-19T13:44:00.219787Z","end":"2026-05-19T13:44:00.373662Z","steps":["trace[1256527883] 'agreement among raft nodes before linearized reading'  (duration: 153.742384ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:44:00.523909Z","caller":"traceutil/trace.go:171","msg":"trace[653932130] transaction","detail":"{read_only:false; response_revision:5028; number_of_response:1; }","duration":"144.947662ms","start":"2026-05-19T13:44:00.378918Z","end":"2026-05-19T13:44:00.523866Z","steps":["trace[653932130] 'process raft request'  (duration: 104.979544ms)","trace[653932130] 'compare'  (duration: 39.656901ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:44:00.524372Z","caller":"traceutil/trace.go:171","msg":"trace[1374116529] transaction","detail":"{read_only:false; response_revision:5029; number_of_response:1; }","duration":"144.932741ms","start":"2026-05-19T13:44:00.379411Z","end":"2026-05-19T13:44:00.524344Z","steps":["trace[1374116529] 'process raft request'  (duration: 144.657415ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:44:00.524473Z","caller":"traceutil/trace.go:171","msg":"trace[721251880] transaction","detail":"{read_only:false; response_revision:5031; number_of_response:1; }","duration":"143.14941ms","start":"2026-05-19T13:44:00.3813Z","end":"2026-05-19T13:44:00.524449Z","steps":["trace[721251880] 'process raft request'  (duration: 142.864814ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:44:00.524466Z","caller":"traceutil/trace.go:171","msg":"trace[2129029983] transaction","detail":"{read_only:false; response_revision:5030; number_of_response:1; }","duration":"144.172314ms","start":"2026-05-19T13:44:00.380258Z","end":"2026-05-19T13:44:00.52443Z","steps":["trace[2129029983] 'process raft request'  (duration: 143.869117ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:44:00.524618Z","caller":"traceutil/trace.go:171","msg":"trace[1115869554] transaction","detail":"{read_only:false; response_revision:5032; number_of_response:1; }","duration":"143.116059ms","start":"2026-05-19T13:44:00.381474Z","end":"2026-05-19T13:44:00.52459Z","steps":["trace[1115869554] 'process raft request'  (duration: 142.738751ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:44:00.524953Z","caller":"traceutil/trace.go:171","msg":"trace[1474626255] transaction","detail":"{read_only:false; response_revision:5033; number_of_response:1; }","duration":"143.372516ms","start":"2026-05-19T13:44:00.381568Z","end":"2026-05-19T13:44:00.524941Z","steps":["trace[1474626255] 'process raft request'  (duration: 142.963506ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:44:00.525639Z","caller":"traceutil/trace.go:171","msg":"trace[2003820562] transaction","detail":"{read_only:false; response_revision:5034; number_of_response:1; }","duration":"142.945466ms","start":"2026-05-19T13:44:00.38267Z","end":"2026-05-19T13:44:00.525615Z","steps":["trace[2003820562] 'process raft request'  (duration: 142.225489ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:44:08.402798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.494526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11497"}
{"level":"info","ts":"2026-05-19T13:44:08.402885Z","caller":"traceutil/trace.go:171","msg":"trace[705638160] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5199; }","duration":"196.63021ms","start":"2026-05-19T13:44:08.206235Z","end":"2026-05-19T13:44:08.402866Z","steps":["trace[705638160] 'range keys from in-memory index tree'  (duration: 196.262181ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:44:08.581265Z","caller":"traceutil/trace.go:171","msg":"trace[909051686] linearizableReadLoop","detail":"{readStateIndex:5425; appliedIndex:5424; }","duration":"100.439438ms","start":"2026-05-19T13:44:08.480804Z","end":"2026-05-19T13:44:08.581243Z","steps":["trace[909051686] 'read index received'  (duration: 100.259774ms)","trace[909051686] 'applied index is now lower than readState.Index'  (duration: 178.724µs)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:44:08.581384Z","caller":"traceutil/trace.go:171","msg":"trace[810970575] transaction","detail":"{read_only:false; response_revision:5200; number_of_response:1; }","duration":"121.780549ms","start":"2026-05-19T13:44:08.459533Z","end":"2026-05-19T13:44:08.581313Z","steps":["trace[810970575] 'process raft request'  (duration: 121.521013ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:44:08.581688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.872978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-19T13:44:08.581772Z","caller":"traceutil/trace.go:171","msg":"trace[1898761983] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5200; }","duration":"101.018662ms","start":"2026-05-19T13:44:08.480735Z","end":"2026-05-19T13:44:08.581754Z","steps":["trace[1898761983] 'agreement among raft nodes before linearized reading'  (duration: 100.627312ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:44:08.791026Z","caller":"traceutil/trace.go:171","msg":"trace[350655432] linearizableReadLoop","detail":"{readStateIndex:5426; appliedIndex:5425; }","duration":"209.67492ms","start":"2026-05-19T13:44:08.581327Z","end":"2026-05-19T13:44:08.791002Z","steps":["trace[350655432] 'read index received'  (duration: 195.183767ms)","trace[350655432] 'applied index is now lower than readState.Index'  (duration: 14.490033ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:44:08.791037Z","caller":"traceutil/trace.go:171","msg":"trace[2128863841] transaction","detail":"{read_only:false; response_revision:5201; number_of_response:1; }","duration":"300.615159ms","start":"2026-05-19T13:44:08.490391Z","end":"2026-05-19T13:44:08.791006Z","steps":["trace[2128863841] 'process raft request'  (duration: 286.022044ms)","trace[2128863841] 'compare'  (duration: 14.449942ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T13:44:08.791178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:44:08.490365Z","time spent":"300.750123ms","remote":"127.0.0.1:58698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":806,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0.18b0fb61621ebb2e\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0.18b0fb61621ebb2e\" value_size:694 lease:3708325342847286451 >> failure:<>"}
{"level":"warn","ts":"2026-05-19T13:44:08.791233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.302485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-05-19T13:44:08.79136Z","caller":"traceutil/trace.go:171","msg":"trace[646455393] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5201; }","duration":"227.456649ms","start":"2026-05-19T13:44:08.563881Z","end":"2026-05-19T13:44:08.791338Z","steps":["trace[646455393] 'agreement among raft nodes before linearized reading'  (duration: 227.149082ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:44:08.791374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.286667ms","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-05-19T13:44:08.791478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.511737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-05-19T13:44:08.791535Z","caller":"traceutil/trace.go:171","msg":"trace[678750659] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5201; }","duration":"233.586639ms","start":"2026-05-19T13:44:08.557936Z","end":"2026-05-19T13:44:08.791523Z","steps":["trace[678750659] 'agreement among raft nodes before linearized reading'  (duration: 233.18603ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:44:08.791504Z","caller":"traceutil/trace.go:171","msg":"trace[797558790] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5201; }","duration":"228.473061ms","start":"2026-05-19T13:44:08.563011Z","end":"2026-05-19T13:44:08.791484Z","steps":["trace[797558790] 'agreement among raft nodes before linearized reading'  (duration: 228.077172ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:44:08.884253Z","caller":"traceutil/trace.go:171","msg":"trace[1192679104] transaction","detail":"{read_only:false; response_revision:5202; number_of_response:1; }","duration":"295.722688ms","start":"2026-05-19T13:44:08.588504Z","end":"2026-05-19T13:44:08.884226Z","steps":["trace[1192679104] 'process raft request'  (duration: 295.394399ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:44:08.884536Z","caller":"traceutil/trace.go:171","msg":"trace[174318671] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5202; }","duration":"295.970213ms","start":"2026-05-19T13:44:08.588509Z","end":"2026-05-19T13:44:08.88448Z","steps":["trace[174318671] 'process raft request'  (duration: 295.588035ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:44:08.884613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.239751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:2318"}
{"level":"info","ts":"2026-05-19T13:44:08.884677Z","caller":"traceutil/trace.go:171","msg":"trace[340322523] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:5202; }","duration":"206.355364ms","start":"2026-05-19T13:44:08.678306Z","end":"2026-05-19T13:44:08.884662Z","steps":["trace[340322523] 'agreement among raft nodes before linearized reading'  (duration: 206.1943ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:44:08.884933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.243787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18b0fb610dc8cb4b\" ","response":"range_response_count:1 size:1012"}
{"level":"info","ts":"2026-05-19T13:44:08.88499Z","caller":"traceutil/trace.go:171","msg":"trace[8260568] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18b0fb610dc8cb4b; range_end:; response_count:1; response_revision:5202; }","duration":"218.329049ms","start":"2026-05-19T13:44:08.666652Z","end":"2026-05-19T13:44:08.884981Z","steps":["trace[8260568] 'agreement among raft nodes before linearized reading'  (duration: 217.763206ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:44:08.960168Z","caller":"traceutil/trace.go:171","msg":"trace[480509145] transaction","detail":"{read_only:false; response_revision:5204; number_of_response:1; }","duration":"164.44487ms","start":"2026-05-19T13:44:08.795686Z","end":"2026-05-19T13:44:08.96013Z","steps":["trace[480509145] 'process raft request'  (duration: 164.327768ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:44:08.960451Z","caller":"traceutil/trace.go:171","msg":"trace[985115217] transaction","detail":"{read_only:false; response_revision:5205; number_of_response:1; }","duration":"161.83077ms","start":"2026-05-19T13:44:08.798371Z","end":"2026-05-19T13:44:08.960201Z","steps":["trace[985115217] 'process raft request'  (duration: 161.687357ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:44:08.960211Z","caller":"traceutil/trace.go:171","msg":"trace[1517392620] transaction","detail":"{read_only:false; response_revision:5203; number_of_response:1; }","duration":"164.668375ms","start":"2026-05-19T13:44:08.795503Z","end":"2026-05-19T13:44:08.960171Z","steps":["trace[1517392620] 'process raft request'  (duration: 128.575826ms)","trace[1517392620] 'compare'  (duration: 35.717971ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:45:36.513439Z","caller":"traceutil/trace.go:171","msg":"trace[1435873337] transaction","detail":"{read_only:false; response_revision:6013; number_of_response:1; }","duration":"116.658665ms","start":"2026-05-19T13:45:36.396742Z","end":"2026-05-19T13:45:36.513401Z","steps":["trace[1435873337] 'process raft request'  (duration: 116.45058ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:46:44.558409Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3242}
{"level":"info","ts":"2026-05-19T13:46:44.64971Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3242,"took":"89.934617ms","hash":1426497697,"current-db-size-bytes":60321792,"current-db-size":"60 MB","current-db-size-in-use-bytes":33619968,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-19T13:46:44.649764Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1426497697,"revision":3242,"compact-revision":-1}
{"level":"info","ts":"2026-05-19T13:50:50.690272Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023a1.wal"}
{"level":"warn","ts":"2026-05-19T13:50:54.545046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.967775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T13:50:54.545125Z","caller":"traceutil/trace.go:171","msg":"trace[629306467] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8751; }","duration":"243.079208ms","start":"2026-05-19T13:50:54.302028Z","end":"2026-05-19T13:50:54.545108Z","steps":["trace[629306467] 'range keys from in-memory index tree'  (duration: 242.842642ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:50:54.545144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.061739ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-19T13:50:54.54523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.93257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T13:50:54.545265Z","caller":"traceutil/trace.go:171","msg":"trace[990698658] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:8751; }","duration":"259.179332ms","start":"2026-05-19T13:50:54.286061Z","end":"2026-05-19T13:50:54.54524Z","steps":["trace[990698658] 'range keys from in-memory index tree'  (duration: 259.030008ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:50:54.54528Z","caller":"traceutil/trace.go:171","msg":"trace[333746554] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:8751; }","duration":"413.057513ms","start":"2026-05-19T13:50:54.132207Z","end":"2026-05-19T13:50:54.545265Z","steps":["trace[333746554] 'count revisions from in-memory index tree'  (duration: 412.850719ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:50:54.545333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:50:54.132187Z","time spent":"413.115015ms","remote":"127.0.0.1:40820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true "}
{"level":"warn","ts":"2026-05-19T13:50:54.545255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.833829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5hww9\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-05-19T13:50:54.546557Z","caller":"traceutil/trace.go:171","msg":"trace[1429643991] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5hww9; range_end:; response_count:1; response_revision:8751; }","duration":"403.175109ms","start":"2026-05-19T13:50:54.143358Z","end":"2026-05-19T13:50:54.546533Z","steps":["trace[1429643991] 'range keys from in-memory index tree'  (duration: 401.600343ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:50:54.546619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:50:54.143334Z","time spent":"403.268942ms","remote":"127.0.0.1:45344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6547,"request content":"key:\"/registry/pods/openstack/keepalived-5hww9\" "}
{"level":"info","ts":"2026-05-19T13:50:54.767393Z","caller":"traceutil/trace.go:171","msg":"trace[1004058367] transaction","detail":"{read_only:false; response_revision:8752; number_of_response:1; }","duration":"172.327338ms","start":"2026-05-19T13:50:54.595023Z","end":"2026-05-19T13:50:54.767351Z","steps":["trace[1004058367] 'process raft request'  (duration: 172.024661ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:51:08.018938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.716688ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12931697379702074723 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.19.213.168\" mod_revision:8772 > success:<request_put:<key:\"/registry/masterleases/199.19.213.168\" value_size:67 lease:3708325342847298913 >> failure:<request_range:<key:\"/registry/masterleases/199.19.213.168\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-19T13:51:08.019061Z","caller":"traceutil/trace.go:171","msg":"trace[512663028] linearizableReadLoop","detail":"{readStateIndex:9246; appliedIndex:9245; }","duration":"192.678076ms","start":"2026-05-19T13:51:07.826365Z","end":"2026-05-19T13:51:08.019043Z","steps":["trace[512663028] 'read index received'  (duration: 51.762414ms)","trace[512663028] 'applied index is now lower than readState.Index'  (duration: 140.914202ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:51:08.019157Z","caller":"traceutil/trace.go:171","msg":"trace[155690417] transaction","detail":"{read_only:false; response_revision:8839; number_of_response:1; }","duration":"238.622148ms","start":"2026-05-19T13:51:07.780524Z","end":"2026-05-19T13:51:08.019146Z","steps":["trace[155690417] 'process raft request'  (duration: 97.589484ms)","trace[155690417] 'compare'  (duration: 140.492333ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T13:51:08.019498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.862192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"}
{"level":"info","ts":"2026-05-19T13:51:08.01958Z","caller":"traceutil/trace.go:171","msg":"trace[2096235904] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8839; }","duration":"102.992355ms","start":"2026-05-19T13:51:07.916569Z","end":"2026-05-19T13:51:08.019561Z","steps":["trace[2096235904] 'agreement among raft nodes before linearized reading'  (duration: 102.723369ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:51:08.019653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.276858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"}
{"level":"info","ts":"2026-05-19T13:51:08.019725Z","caller":"traceutil/trace.go:171","msg":"trace[1929668036] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8839; }","duration":"193.383591ms","start":"2026-05-19T13:51:07.826317Z","end":"2026-05-19T13:51:08.019701Z","steps":["trace[1929668036] 'agreement among raft nodes before linearized reading'  (duration: 193.164926ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:51:08.327655Z","caller":"traceutil/trace.go:171","msg":"trace[427397575] transaction","detail":"{read_only:false; response_revision:8840; number_of_response:1; }","duration":"299.839028ms","start":"2026-05-19T13:51:08.027794Z","end":"2026-05-19T13:51:08.327633Z","steps":["trace[427397575] 'process raft request'  (duration: 299.694765ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:51:08.336804Z","caller":"traceutil/trace.go:171","msg":"trace[1053585466] linearizableReadLoop","detail":"{readStateIndex:9248; appliedIndex:9247; }","duration":"253.521217ms","start":"2026-05-19T13:51:08.083258Z","end":"2026-05-19T13:51:08.336779Z","steps":["trace[1053585466] 'read index received'  (duration: 244.572201ms)","trace[1053585466] 'applied index is now lower than readState.Index'  (duration: 8.947926ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:51:08.336881Z","caller":"traceutil/trace.go:171","msg":"trace[899129810] transaction","detail":"{read_only:false; response_revision:8841; number_of_response:1; }","duration":"308.563169ms","start":"2026-05-19T13:51:08.028282Z","end":"2026-05-19T13:51:08.336845Z","steps":["trace[899129810] 'process raft request'  (duration: 308.367415ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:51:08.337026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.771863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:525"}
{"level":"warn","ts":"2026-05-19T13:51:08.337045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:51:08.028273Z","time spent":"308.674181ms","remote":"127.0.0.1:58724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":644,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" mod_revision:8828 > success:<request_put:<key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" value_size:562 >> failure:<request_range:<key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-19T13:51:08.337067Z","caller":"traceutil/trace.go:171","msg":"trace[2112316813] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:8841; }","duration":"253.871985ms","start":"2026-05-19T13:51:08.083185Z","end":"2026-05-19T13:51:08.337057Z","steps":["trace[2112316813] 'agreement among raft nodes before linearized reading'  (duration: 253.720232ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:51:34.658539Z","caller":"traceutil/trace.go:171","msg":"trace[335676612] linearizableReadLoop","detail":"{readStateIndex:9488; appliedIndex:9487; }","duration":"103.336753ms","start":"2026-05-19T13:51:34.555175Z","end":"2026-05-19T13:51:34.658512Z","steps":["trace[335676612] 'read index received'  (duration: 103.128969ms)","trace[335676612] 'applied index is now lower than readState.Index'  (duration: 206.844µs)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:51:34.658973Z","caller":"traceutil/trace.go:171","msg":"trace[2137601573] transaction","detail":"{read_only:false; response_revision:9069; number_of_response:1; }","duration":"135.02373ms","start":"2026-05-19T13:51:34.523934Z","end":"2026-05-19T13:51:34.658958Z","steps":["trace[2137601573] 'process raft request'  (duration: 134.435968ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:51:34.659288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.073938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-19T13:51:34.659348Z","caller":"traceutil/trace.go:171","msg":"trace[296215570] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:9069; }","duration":"104.18317ms","start":"2026-05-19T13:51:34.555148Z","end":"2026-05-19T13:51:34.659331Z","steps":["trace[296215570] 'agreement among raft nodes before linearized reading'  (duration: 104.067038ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:51:36.806229Z","caller":"traceutil/trace.go:171","msg":"trace[1952940312] linearizableReadLoop","detail":"{readStateIndex:9502; appliedIndex:9501; }","duration":"111.84475ms","start":"2026-05-19T13:51:36.694358Z","end":"2026-05-19T13:51:36.806202Z","steps":["trace[1952940312] 'read index received'  (duration: 111.571414ms)","trace[1952940312] 'applied index is now lower than readState.Index'  (duration: 271.886µs)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:51:36.806401Z","caller":"traceutil/trace.go:171","msg":"trace[763187368] transaction","detail":"{read_only:false; response_revision:9082; number_of_response:1; }","duration":"135.384577ms","start":"2026-05-19T13:51:36.670975Z","end":"2026-05-19T13:51:36.80636Z","steps":["trace[763187368] 'process raft request'  (duration: 135.05997ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:51:36.806458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.081134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"}
{"level":"info","ts":"2026-05-19T13:51:36.806498Z","caller":"traceutil/trace.go:171","msg":"trace[2037283298] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:9082; }","duration":"112.171706ms","start":"2026-05-19T13:51:36.694313Z","end":"2026-05-19T13:51:36.806485Z","steps":["trace[2037283298] 'agreement among raft nodes before linearized reading'  (duration: 112.020403ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:51:36.806521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.904329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"}
{"level":"info","ts":"2026-05-19T13:51:36.806592Z","caller":"traceutil/trace.go:171","msg":"trace[1869448821] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:9082; }","duration":"112.000171ms","start":"2026-05-19T13:51:36.694575Z","end":"2026-05-19T13:51:36.806575Z","steps":["trace[1869448821] 'agreement among raft nodes before linearized reading'  (duration: 111.803917ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:51:44.567445Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6559}
{"level":"info","ts":"2026-05-19T13:51:44.670872Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6559,"took":"101.179538ms","hash":2978852403,"current-db-size-bytes":60321792,"current-db-size":"60 MB","current-db-size-in-use-bytes":25088000,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-05-19T13:51:44.670937Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2978852403,"revision":6559,"compact-revision":3242}
{"level":"info","ts":"2026-05-19T13:51:49.119212Z","caller":"traceutil/trace.go:171","msg":"trace[1837668975] transaction","detail":"{read_only:false; response_revision:9178; number_of_response:1; }","duration":"154.676978ms","start":"2026-05-19T13:51:48.964515Z","end":"2026-05-19T13:51:49.119192Z","steps":["trace[1837668975] 'process raft request'  (duration: 154.541965ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:51:49.131681Z","caller":"traceutil/trace.go:171","msg":"trace[2058667113] transaction","detail":"{read_only:false; response_revision:9179; number_of_response:1; }","duration":"165.181675ms","start":"2026-05-19T13:51:48.966451Z","end":"2026-05-19T13:51:49.131633Z","steps":["trace[2058667113] 'process raft request'  (duration: 165.021252ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:51:49.787926Z","caller":"traceutil/trace.go:171","msg":"trace[942637369] linearizableReadLoop","detail":"{readStateIndex:9612; appliedIndex:9611; }","duration":"177.391709ms","start":"2026-05-19T13:51:49.61051Z","end":"2026-05-19T13:51:49.787902Z","steps":["trace[942637369] 'read index received'  (duration: 135.00951ms)","trace[942637369] 'applied index is now lower than readState.Index'  (duration: 42.381208ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:51:49.788043Z","caller":"traceutil/trace.go:171","msg":"trace[1014217928] transaction","detail":"{read_only:false; response_revision:9185; number_of_response:1; }","duration":"207.408411ms","start":"2026-05-19T13:51:49.580598Z","end":"2026-05-19T13:51:49.788007Z","steps":["trace[1014217928] 'process raft request'  (duration: 164.90651ms)","trace[1014217928] 'compare'  (duration: 42.277016ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T13:51:49.788137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.613023ms","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-05-19T13:51:49.788179Z","caller":"traceutil/trace.go:171","msg":"trace[642576630] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9185; }","duration":"177.701155ms","start":"2026-05-19T13:51:49.610466Z","end":"2026-05-19T13:51:49.788167Z","steps":["trace[642576630] 'agreement among raft nodes before linearized reading'  (duration: 177.554441ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:51:49.848137Z","caller":"traceutil/trace.go:171","msg":"trace[53747612] transaction","detail":"{read_only:false; response_revision:9186; number_of_response:1; }","duration":"203.95356ms","start":"2026-05-19T13:51:49.644152Z","end":"2026-05-19T13:51:49.848106Z","steps":["trace[53747612] 'process raft request'  (duration: 203.697214ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:51:49.848137Z","caller":"traceutil/trace.go:171","msg":"trace[1349073629] transaction","detail":"{read_only:false; response_revision:9187; number_of_response:1; }","duration":"174.700322ms","start":"2026-05-19T13:51:49.673411Z","end":"2026-05-19T13:51:49.848111Z","steps":["trace[1349073629] 'process raft request'  (duration: 174.5978ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:51:49.84837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.532803ms","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":"warn","ts":"2026-05-19T13:51:49.848384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.08666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/cephfs-csi-nodeplugin\" ","response":"range_response_count:1 size:603"}
{"level":"info","ts":"2026-05-19T13:51:49.848426Z","caller":"traceutil/trace.go:171","msg":"trace[2043647974] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9188; }","duration":"232.619764ms","start":"2026-05-19T13:51:49.615795Z","end":"2026-05-19T13:51:49.848415Z","steps":["trace[2043647974] 'agreement among raft nodes before linearized reading'  (duration: 232.43006ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:51:49.848436Z","caller":"traceutil/trace.go:171","msg":"trace[105611288] range","detail":"{range_begin:/registry/clusterroles/cephfs-csi-nodeplugin; range_end:; response_count:1; response_revision:9188; }","duration":"188.164881ms","start":"2026-05-19T13:51:49.660259Z","end":"2026-05-19T13:51:49.848423Z","steps":["trace[105611288] 'agreement among raft nodes before linearized reading'  (duration: 187.977687ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:51:49.848455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.604321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-84txf\" ","response":"range_response_count:1 size:4615"}
{"level":"info","ts":"2026-05-19T13:51:49.848547Z","caller":"traceutil/trace.go:171","msg":"trace[1283970764] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-84txf; range_end:; response_count:1; response_revision:9188; }","duration":"175.734634ms","start":"2026-05-19T13:51:49.672792Z","end":"2026-05-19T13:51:49.848527Z","steps":["trace[1283970764] 'agreement among raft nodes before linearized reading'  (duration: 175.436928ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:51:49.848473Z","caller":"traceutil/trace.go:171","msg":"trace[852206974] transaction","detail":"{read_only:false; response_revision:9188; number_of_response:1; }","duration":"166.750008ms","start":"2026-05-19T13:51:49.681692Z","end":"2026-05-19T13:51:49.848442Z","steps":["trace[852206974] 'process raft request'  (duration: 166.36837ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:51:49.848742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.724477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/cephfs-external-provisioner-runner\" ","response":"range_response_count:1 size:1297"}
{"level":"info","ts":"2026-05-19T13:51:49.848895Z","caller":"traceutil/trace.go:171","msg":"trace[1659609117] range","detail":"{range_begin:/registry/clusterroles/cephfs-external-provisioner-runner; range_end:; response_count:1; response_revision:9188; }","duration":"192.92273ms","start":"2026-05-19T13:51:49.655945Z","end":"2026-05-19T13:51:49.848868Z","steps":["trace[1659609117] 'agreement among raft nodes before linearized reading'  (duration: 192.40405ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:51:50.105128Z","caller":"traceutil/trace.go:171","msg":"trace[812231405] linearizableReadLoop","detail":"{readStateIndex:9616; appliedIndex:9615; }","duration":"252.734591ms","start":"2026-05-19T13:51:49.852375Z","end":"2026-05-19T13:51:50.10511Z","steps":["trace[812231405] 'read index received'  (duration: 229.284314ms)","trace[812231405] 'applied index is now lower than readState.Index'  (duration: 23.449177ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:51:50.105125Z","caller":"traceutil/trace.go:171","msg":"trace[1095197989] transaction","detail":"{read_only:false; response_revision:9189; number_of_response:1; }","duration":"313.196975ms","start":"2026-05-19T13:51:49.791892Z","end":"2026-05-19T13:51:50.105089Z","steps":["trace[1095197989] 'process raft request'  (duration: 289.746118ms)","trace[1095197989] 'compare'  (duration: 23.324244ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T13:51:50.105448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:51:49.79187Z","time spent":"313.45007ms","remote":"127.0.0.1:45416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:9160 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-19T13:51:50.105495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.063858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/cephfs-csi-nodeplugin\" ","response":"range_response_count:1 size:603"}
{"level":"warn","ts":"2026-05-19T13:51:50.105457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.148849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/cephfs-external-provisioner-runner\" ","response":"range_response_count:1 size:1297"}
{"level":"info","ts":"2026-05-19T13:51:50.105642Z","caller":"traceutil/trace.go:171","msg":"trace[1354734145] range","detail":"{range_begin:/registry/clusterroles/cephfs-external-provisioner-runner; range_end:; response_count:1; response_revision:9190; }","duration":"252.339532ms","start":"2026-05-19T13:51:49.853261Z","end":"2026-05-19T13:51:50.1056Z","steps":["trace[1354734145] 'agreement among raft nodes before linearized reading'  (duration: 252.027036ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:51:50.105443Z","caller":"traceutil/trace.go:171","msg":"trace[237267141] transaction","detail":"{read_only:false; response_revision:9190; number_of_response:1; }","duration":"251.405724ms","start":"2026-05-19T13:51:49.853834Z","end":"2026-05-19T13:51:50.10524Z","steps":["trace[237267141] 'process raft request'  (duration: 251.22601ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:51:50.105619Z","caller":"traceutil/trace.go:171","msg":"trace[609495345] range","detail":"{range_begin:/registry/clusterroles/cephfs-csi-nodeplugin; range_end:; response_count:1; response_revision:9190; }","duration":"253.262432ms","start":"2026-05-19T13:51:49.852325Z","end":"2026-05-19T13:51:50.105588Z","steps":["trace[609495345] 'agreement among raft nodes before linearized reading'  (duration: 252.849093ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:51:51.212047Z","caller":"traceutil/trace.go:171","msg":"trace[146992735] linearizableReadLoop","detail":"{readStateIndex:9618; appliedIndex:9617; }","duration":"284.071772ms","start":"2026-05-19T13:51:50.927943Z","end":"2026-05-19T13:51:51.212015Z","steps":["trace[146992735] 'read index received'  (duration: 283.683694ms)","trace[146992735] 'applied index is now lower than readState.Index'  (duration: 386.867µs)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:51:51.212212Z","caller":"traceutil/trace.go:171","msg":"trace[408330398] transaction","detail":"{read_only:false; response_revision:9191; number_of_response:1; }","duration":"288.905231ms","start":"2026-05-19T13:51:50.92329Z","end":"2026-05-19T13:51:51.212195Z","steps":["trace[408330398] 'process raft request'  (duration: 288.425561ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:51:51.212429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.579225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/cert-manager-controller-orders\" ","response":"range_response_count:1 size:1347"}
{"level":"warn","ts":"2026-05-19T13:51:51.212428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.466039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5hww9\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-05-19T13:51:51.212496Z","caller":"traceutil/trace.go:171","msg":"trace[844387317] range","detail":"{range_begin:/registry/clusterroles/cert-manager-controller-orders; range_end:; response_count:1; response_revision:9191; }","duration":"249.696347ms","start":"2026-05-19T13:51:50.962786Z","end":"2026-05-19T13:51:51.212482Z","steps":["trace[844387317] 'agreement among raft nodes before linearized reading'  (duration: 249.475493ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:51:51.212519Z","caller":"traceutil/trace.go:171","msg":"trace[785723811] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5hww9; range_end:; response_count:1; response_revision:9191; }","duration":"284.600262ms","start":"2026-05-19T13:51:50.927898Z","end":"2026-05-19T13:51:51.212499Z","steps":["trace[785723811] 'agreement among raft nodes before linearized reading'  (duration: 284.351597ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T13:51:51.212884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.027328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/cert-manager-edit\" ","response":"range_response_count:1 size:1437"}
{"level":"info","ts":"2026-05-19T13:51:51.212949Z","caller":"traceutil/trace.go:171","msg":"trace[986881818] range","detail":"{range_begin:/registry/clusterroles/cert-manager-edit; range_end:; response_count:1; response_revision:9191; }","duration":"227.13314ms","start":"2026-05-19T13:51:50.9858Z","end":"2026-05-19T13:51:51.212933Z","steps":["trace[986881818] 'agreement among raft nodes before linearized reading'  (duration: 226.933146ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:51:51.351613Z","caller":"traceutil/trace.go:171","msg":"trace[1201782698] transaction","detail":"{read_only:false; response_revision:9192; number_of_response:1; }","duration":"131.308243ms","start":"2026-05-19T13:51:51.220279Z","end":"2026-05-19T13:51:51.351587Z","steps":["trace[1201782698] 'process raft request'  (duration: 44.671547ms)","trace[1201782698] 'compare'  (duration: 86.497873ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:51:51.367586Z","caller":"traceutil/trace.go:171","msg":"trace[446502287] transaction","detail":"{read_only:false; response_revision:9193; number_of_response:1; }","duration":"146.64374ms","start":"2026-05-19T13:51:51.22091Z","end":"2026-05-19T13:51:51.367554Z","steps":["trace[446502287] 'process raft request'  (duration: 146.422246ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:51:51.367837Z","caller":"traceutil/trace.go:171","msg":"trace[1220634341] transaction","detail":"{read_only:false; response_revision:9194; number_of_response:1; }","duration":"107.650382ms","start":"2026-05-19T13:51:51.260169Z","end":"2026-05-19T13:51:51.367819Z","steps":["trace[1220634341] 'process raft request'  (duration: 107.341845ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:51:51.506649Z","caller":"traceutil/trace.go:171","msg":"trace[379561319] transaction","detail":"{read_only:false; number_of_response:0; response_revision:9195; }","duration":"130.305533ms","start":"2026-05-19T13:51:51.376302Z","end":"2026-05-19T13:51:51.506608Z","steps":["trace[379561319] 'process raft request'  (duration: 75.146639ms)","trace[379561319] 'compare'  (duration: 55.010871ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:51:51.506741Z","caller":"traceutil/trace.go:171","msg":"trace[646109031] transaction","detail":"{read_only:false; response_revision:9196; number_of_response:1; }","duration":"129.952524ms","start":"2026-05-19T13:51:51.376759Z","end":"2026-05-19T13:51:51.506711Z","steps":["trace[646109031] 'process raft request'  (duration: 129.770981ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:51:51.667599Z","caller":"traceutil/trace.go:171","msg":"trace[953640386] transaction","detail":"{read_only:false; response_revision:9198; number_of_response:1; }","duration":"154.800399ms","start":"2026-05-19T13:51:51.512773Z","end":"2026-05-19T13:51:51.667573Z","steps":["trace[953640386] 'process raft request'  (duration: 109.904459ms)","trace[953640386] 'compare'  (duration: 44.486432ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T13:51:51.667777Z","caller":"traceutil/trace.go:171","msg":"trace[465758727] transaction","detail":"{read_only:false; response_revision:9199; number_of_response:1; }","duration":"147.789383ms","start":"2026-05-19T13:51:51.519977Z","end":"2026-05-19T13:51:51.667767Z","steps":["trace[465758727] 'process raft request'  (duration: 147.399865ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T13:52:37.732439Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"8ae391decac9b376","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-19T13:52:37.742023Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-19T13:52:37.742111Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}