{"level":"warn","ts":"2026-04-19T11:06:08.219115Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-19T11:06:08.219219Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.138: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.138:2380","--initial-cluster=instance=https://199.19.213.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.138:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-04-19T11:06:08.219301Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-19T11:06:08.219316Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.138:2380"]}
{"level":"info","ts":"2026-04-19T11:06:08.219337Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-04-19T11:06:08.220018Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.138:2379"]}
{"level":"info","ts":"2026-04-19T11:06:08.220093Z","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.138:2380"],"listen-peer-urls":["https://199.19.213.138:2380"],"advertise-client-urls":["https://199.19.213.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.138:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-04-19T11:06:08.223973Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.640904ms"}
{"level":"info","ts":"2026-04-19T11:06:08.229556Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2062be27cfb43adb","cluster-id":"f353072e75ed4d57"}
{"level":"info","ts":"2026-04-19T11:06:08.229682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb switched to configuration voters=()"}
{"level":"info","ts":"2026-04-19T11:06:08.229717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb became follower at term 0"}
{"level":"info","ts":"2026-04-19T11:06:08.229738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2062be27cfb43adb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-19T11:06:08.229747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb became follower at term 1"}
{"level":"info","ts":"2026-04-19T11:06:08.229812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb switched to configuration voters=(2333636635129035483)"}
{"level":"warn","ts":"2026-04-19T11:06:08.240038Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-19T11:06:08.242873Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-19T11:06:08.244979Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-04-19T11:06:08.248372Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2062be27cfb43adb","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-19T11:06:08.249071Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-19T11:06:08.249158Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-19T11:06:08.249169Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-19T11:06:08.249533Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2062be27cfb43adb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-19T11:06:08.250958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb switched to configuration voters=(2333636635129035483)"}
{"level":"info","ts":"2026-04-19T11:06:08.251534Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f353072e75ed4d57","local-member-id":"2062be27cfb43adb","added-peer-id":"2062be27cfb43adb","added-peer-peer-urls":["https://199.19.213.138:2380"]}
{"level":"info","ts":"2026-04-19T11:06:08.253681Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-04-19T11:06:08.254004Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2062be27cfb43adb","initial-advertise-peer-urls":["https://199.19.213.138:2380"],"listen-peer-urls":["https://199.19.213.138:2380"],"advertise-client-urls":["https://199.19.213.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-19T11:06:08.254067Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-19T11:06:08.254525Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.138:2380"}
{"level":"info","ts":"2026-04-19T11:06:08.25459Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.138:2380"}
{"level":"info","ts":"2026-04-19T11:06:09.130676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb is starting a new election at term 1"}
{"level":"info","ts":"2026-04-19T11:06:09.130771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-19T11:06:09.130813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb received MsgPreVoteResp from 2062be27cfb43adb at term 1"}
{"level":"info","ts":"2026-04-19T11:06:09.130838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb became candidate at term 2"}
{"level":"info","ts":"2026-04-19T11:06:09.130857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb received MsgVoteResp from 2062be27cfb43adb at term 2"}
{"level":"info","ts":"2026-04-19T11:06:09.130873Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb became leader at term 2"}
{"level":"info","ts":"2026-04-19T11:06:09.130895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2062be27cfb43adb elected leader 2062be27cfb43adb at term 2"}
{"level":"info","ts":"2026-04-19T11:06:09.132307Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-19T11:06:09.132653Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2062be27cfb43adb","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.138:2379]}","request-path":"/0/members/2062be27cfb43adb/attributes","cluster-id":"f353072e75ed4d57","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-19T11:06:09.132655Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-19T11:06:09.132673Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-19T11:06:09.133138Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-19T11:06:09.133239Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-19T11:06:09.1347Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.138:2379"}
{"level":"info","ts":"2026-04-19T11:06:09.135703Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-19T11:06:09.143034Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f353072e75ed4d57","local-member-id":"2062be27cfb43adb","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-19T11:06:09.14317Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-19T11:06:09.143216Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-19T11:06:24.98469Z","caller":"traceutil/trace.go:171","msg":"trace[1127527427] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"148.779878ms","start":"2026-04-19T11:06:24.835871Z","end":"2026-04-19T11:06:24.984651Z","steps":["trace[1127527427] 'process raft request'  (duration: 148.594444ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:06:51.220546Z","caller":"traceutil/trace.go:171","msg":"trace[21174205] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"184.70141ms","start":"2026-04-19T11:06:51.035811Z","end":"2026-04-19T11:06:51.220512Z","steps":["trace[21174205] 'process raft request'  (duration: 182.98297ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:06:51.43025Z","caller":"traceutil/trace.go:171","msg":"trace[737773766] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"198.314821ms","start":"2026-04-19T11:06:51.231904Z","end":"2026-04-19T11:06:51.430219Z","steps":["trace[737773766] 'process raft request'  (duration: 198.057475ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:06:51.446333Z","caller":"traceutil/trace.go:171","msg":"trace[1361772456] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:613; }","duration":"137.506809ms","start":"2026-04-19T11:06:51.308785Z","end":"2026-04-19T11:06:51.446292Z","steps":["trace[1361772456] 'read index received'  (duration: 121.236806ms)","trace[1361772456] 'applied index is now lower than readState.Index'  (duration: 16.268483ms)"],"step_count":2}
{"level":"info","ts":"2026-04-19T11:06:51.446411Z","caller":"traceutil/trace.go:171","msg":"trace[1742336918] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"164.770574ms","start":"2026-04-19T11:06:51.281602Z","end":"2026-04-19T11:06:51.446372Z","steps":["trace[1742336918] 'process raft request'  (duration: 164.515318ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:06:51.446736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.637311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-04-19T11:06:51.446833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.944089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-fhvv4\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-04-19T11:06:51.446894Z","caller":"traceutil/trace.go:171","msg":"trace[208613576] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:590; }","duration":"130.870276ms","start":"2026-04-19T11:06:51.316007Z","end":"2026-04-19T11:06:51.446877Z","steps":["trace[208613576] 'agreement among raft nodes before linearized reading'  (duration: 130.478097ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:06:51.446943Z","caller":"traceutil/trace.go:171","msg":"trace[2040067516] range","detail":"{range_begin:/registry/pods/kube-system/cilium-fhvv4; range_end:; response_count:1; response_revision:590; }","duration":"138.194195ms","start":"2026-04-19T11:06:51.30872Z","end":"2026-04-19T11:06:51.446914Z","steps":["trace[2040067516] 'agreement among raft nodes before linearized reading'  (duration: 137.777605ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:06:51.98185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.521623ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4241156807895411247 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/cilium-fhvv4\" mod_revision:479 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-fhvv4\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-fhvv4\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-19T11:06:51.982046Z","caller":"traceutil/trace.go:171","msg":"trace[1985044430] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"517.969331ms","start":"2026-04-19T11:06:51.464033Z","end":"2026-04-19T11:06:51.982003Z","steps":["trace[1985044430] 'process raft request'  (duration: 326.494926ms)","trace[1985044430] 'compare'  (duration: 190.323439ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-19T11:06:51.982221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:06:51.464002Z","time spent":"518.130785ms","remote":"127.0.0.1:42920","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-fhvv4\" mod_revision:479 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-fhvv4\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-fhvv4\" > >"}
{"level":"info","ts":"2026-04-19T11:06:51.982345Z","caller":"traceutil/trace.go:171","msg":"trace[1215208527] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"441.580943ms","start":"2026-04-19T11:06:51.540737Z","end":"2026-04-19T11:06:51.982318Z","steps":["trace[1215208527] 'process raft request'  (duration: 441.264205ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:06:51.982074Z","caller":"traceutil/trace.go:171","msg":"trace[677448450] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:616; }","duration":"490.433021ms","start":"2026-04-19T11:06:51.491617Z","end":"2026-04-19T11:06:51.98205Z","steps":["trace[677448450] 'read index received'  (duration: 299.056188ms)","trace[677448450] 'applied index is now lower than readState.Index'  (duration: 191.373803ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-19T11:06:51.982497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.846542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-19T11:06:51.982509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:06:51.540716Z","time spent":"441.691535ms","remote":"127.0.0.1:42978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:443 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-04-19T11:06:51.982577Z","caller":"traceutil/trace.go:171","msg":"trace[435182644] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:593; }","duration":"491.004985ms","start":"2026-04-19T11:06:51.491546Z","end":"2026-04-19T11:06:51.982551Z","steps":["trace[435182644] 'agreement among raft nodes before linearized reading'  (duration: 490.572335ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:06:51.982646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:06:51.491512Z","time spent":"491.119378ms","remote":"127.0.0.1:42720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-19T11:06:51.983181Z","caller":"traceutil/trace.go:171","msg":"trace[655334548] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"101.056064ms","start":"2026-04-19T11:06:51.882106Z","end":"2026-04-19T11:06:51.983162Z","steps":["trace[655334548] 'process raft request'  (duration: 100.317587ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:07:34.799187Z","caller":"traceutil/trace.go:171","msg":"trace[849661181] transaction","detail":"{read_only:false; response_revision:1150; number_of_response:1; }","duration":"241.689206ms","start":"2026-04-19T11:07:34.557466Z","end":"2026-04-19T11:07:34.799156Z","steps":["trace[849661181] 'process raft request'  (duration: 241.456031ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:08:20.94118Z","caller":"traceutil/trace.go:171","msg":"trace[1137421102] linearizableReadLoop","detail":"{readStateIndex:1885; appliedIndex:1884; }","duration":"121.177088ms","start":"2026-04-19T11:08:20.819974Z","end":"2026-04-19T11:08:20.941151Z","steps":["trace[1137421102] 'read index received'  (duration: 120.880012ms)","trace[1137421102] 'applied index is now lower than readState.Index'  (duration: 296.206µs)"],"step_count":2}
{"level":"info","ts":"2026-04-19T11:08:20.941291Z","caller":"traceutil/trace.go:171","msg":"trace[381625023] transaction","detail":"{read_only:false; response_revision:1811; number_of_response:1; }","duration":"131.79808ms","start":"2026-04-19T11:08:20.809432Z","end":"2026-04-19T11:08:20.94123Z","steps":["trace[381625023] 'process raft request'  (duration: 131.539874ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:08:20.94145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.449754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"info","ts":"2026-04-19T11:08:20.941491Z","caller":"traceutil/trace.go:171","msg":"trace[489725396] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1811; }","duration":"121.560197ms","start":"2026-04-19T11:08:20.819919Z","end":"2026-04-19T11:08:20.941479Z","steps":["trace[489725396] 'agreement among raft nodes before linearized reading'  (duration: 121.378463ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:09:06.608463Z","caller":"traceutil/trace.go:171","msg":"trace[1487223803] linearizableReadLoop","detail":"{readStateIndex:2200; appliedIndex:2199; }","duration":"122.403401ms","start":"2026-04-19T11:09:06.486022Z","end":"2026-04-19T11:09:06.608426Z","steps":["trace[1487223803] 'read index received'  (duration: 72.375912ms)","trace[1487223803] 'applied index is now lower than readState.Index'  (duration: 50.026409ms)"],"step_count":2}
{"level":"info","ts":"2026-04-19T11:09:06.608527Z","caller":"traceutil/trace.go:171","msg":"trace[1376583242] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"130.873171ms","start":"2026-04-19T11:09:06.477625Z","end":"2026-04-19T11:09:06.608498Z","steps":["trace[1376583242] 'process raft request'  (duration: 80.71672ms)","trace[1376583242] 'compare'  (duration: 49.918526ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-19T11:09:06.608705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.805044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-19T11:09:06.608745Z","caller":"traceutil/trace.go:171","msg":"trace[587477645] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2117; }","duration":"116.887865ms","start":"2026-04-19T11:09:06.491846Z","end":"2026-04-19T11:09:06.608733Z","steps":["trace[587477645] 'agreement among raft nodes before linearized reading'  (duration: 116.779913ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:09:06.608837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.790319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-04-19T11:09:06.608955Z","caller":"traceutil/trace.go:171","msg":"trace[1140877649] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2117; }","duration":"122.982754ms","start":"2026-04-19T11:09:06.485942Z","end":"2026-04-19T11:09:06.608925Z","steps":["trace[1140877649] 'agreement among raft nodes before linearized reading'  (duration: 122.688727ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:09:56.116345Z","caller":"traceutil/trace.go:171","msg":"trace[1351246963] linearizableReadLoop","detail":"{readStateIndex:2523; appliedIndex:2522; }","duration":"100.391217ms","start":"2026-04-19T11:09:56.015924Z","end":"2026-04-19T11:09:56.116315Z","steps":["trace[1351246963] 'read index received'  (duration: 100.256424ms)","trace[1351246963] 'applied index is now lower than readState.Index'  (duration: 133.613µs)"],"step_count":2}
{"level":"info","ts":"2026-04-19T11:09:56.116477Z","caller":"traceutil/trace.go:171","msg":"trace[1899644202] transaction","detail":"{read_only:false; response_revision:2429; number_of_response:1; }","duration":"194.114015ms","start":"2026-04-19T11:09:55.922299Z","end":"2026-04-19T11:09:56.116413Z","steps":["trace[1899644202] 'process raft request'  (duration: 193.836459ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:09:56.116612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.665683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-04-19T11:09:56.116644Z","caller":"traceutil/trace.go:171","msg":"trace[555411093] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2429; }","duration":"100.775736ms","start":"2026-04-19T11:09:56.01586Z","end":"2026-04-19T11:09:56.116635Z","steps":["trace[555411093] 'agreement among raft nodes before linearized reading'  (duration: 100.588842ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:10:29.814698Z","caller":"traceutil/trace.go:171","msg":"trace[472955437] transaction","detail":"{read_only:false; response_revision:2617; number_of_response:1; }","duration":"120.355464ms","start":"2026-04-19T11:10:29.694311Z","end":"2026-04-19T11:10:29.814666Z","steps":["trace[472955437] 'process raft request'  (duration: 120.073478ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:10:30.006009Z","caller":"traceutil/trace.go:171","msg":"trace[1711935858] transaction","detail":"{read_only:false; response_revision:2619; number_of_response:1; }","duration":"108.675163ms","start":"2026-04-19T11:10:29.8973Z","end":"2026-04-19T11:10:30.005975Z","steps":["trace[1711935858] 'process raft request'  (duration: 91.013897ms)","trace[1711935858] 'compare'  (duration: 17.520913ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-19T11:10:30.006046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.053932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1366"}
{"level":"info","ts":"2026-04-19T11:10:30.006184Z","caller":"traceutil/trace.go:171","msg":"trace[786781553] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2618; }","duration":"109.245016ms","start":"2026-04-19T11:10:29.896916Z","end":"2026-04-19T11:10:30.006161Z","steps":["trace[786781553] 'range keys from in-memory index tree'  (duration: 108.604971ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:14:49.903413Z","caller":"traceutil/trace.go:171","msg":"trace[1121230846] transaction","detail":"{read_only:false; response_revision:4872; number_of_response:1; }","duration":"129.858718ms","start":"2026-04-19T11:14:49.773526Z","end":"2026-04-19T11:14:49.903385Z","steps":["trace[1121230846] 'process raft request'  (duration: 129.708224ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:14:50.030663Z","caller":"traceutil/trace.go:171","msg":"trace[1650297467] linearizableReadLoop","detail":"{readStateIndex:5058; appliedIndex:5056; }","duration":"186.866311ms","start":"2026-04-19T11:14:49.843776Z","end":"2026-04-19T11:14:50.030642Z","steps":["trace[1650297467] 'read index received'  (duration: 59.786885ms)","trace[1650297467] 'applied index is now lower than readState.Index'  (duration: 127.078556ms)"],"step_count":2}
{"level":"info","ts":"2026-04-19T11:14:50.030796Z","caller":"traceutil/trace.go:171","msg":"trace[1297635237] transaction","detail":"{read_only:false; response_revision:4874; number_of_response:1; }","duration":"216.441058ms","start":"2026-04-19T11:14:49.814301Z","end":"2026-04-19T11:14:50.030742Z","steps":["trace[1297635237] 'process raft request'  (duration: 216.290994ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:14:50.030871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.081986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-04-19T11:14:50.03091Z","caller":"traceutil/trace.go:171","msg":"trace[787385387] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4874; }","duration":"187.160608ms","start":"2026-04-19T11:14:49.843739Z","end":"2026-04-19T11:14:50.0309Z","steps":["trace[787385387] 'agreement among raft nodes before linearized reading'  (duration: 186.989675ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:14:50.030887Z","caller":"traceutil/trace.go:171","msg":"trace[424598222] transaction","detail":"{read_only:false; response_revision:4873; number_of_response:1; }","duration":"255.451203ms","start":"2026-04-19T11:14:49.775326Z","end":"2026-04-19T11:14:50.030777Z","steps":["trace[424598222] 'process raft request'  (duration: 255.097104ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:15:02.147665Z","caller":"traceutil/trace.go:171","msg":"trace[1610979477] transaction","detail":"{read_only:false; response_revision:5115; number_of_response:1; }","duration":"106.447159ms","start":"2026-04-19T11:15:02.041181Z","end":"2026-04-19T11:15:02.147628Z","steps":["trace[1610979477] 'process raft request'  (duration: 106.205054ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:15:10.169838Z","caller":"traceutil/trace.go:171","msg":"trace[1437083047] transaction","detail":"{read_only:false; response_revision:5262; number_of_response:1; }","duration":"109.892356ms","start":"2026-04-19T11:15:10.05992Z","end":"2026-04-19T11:15:10.169813Z","steps":["trace[1437083047] 'process raft request'  (duration: 109.730622ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:15:10.405061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.363279ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4241156807895422312 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/monitoring/prometheus-pushgateway-7c6f84b96c-6rkfg\" mod_revision:5015 > success:<request_put:<key:\"/registry/pods/monitoring/prometheus-pushgateway-7c6f84b96c-6rkfg\" value_size:4256 >> failure:<request_range:<key:\"/registry/pods/monitoring/prometheus-pushgateway-7c6f84b96c-6rkfg\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-19T11:15:10.40518Z","caller":"traceutil/trace.go:171","msg":"trace[1668727481] linearizableReadLoop","detail":"{readStateIndex:5457; appliedIndex:5456; }","duration":"168.344522ms","start":"2026-04-19T11:15:10.236818Z","end":"2026-04-19T11:15:10.405163Z","steps":["trace[1668727481] 'read index received'  (duration: 37.783148ms)","trace[1668727481] 'applied index is now lower than readState.Index'  (duration: 130.560014ms)"],"step_count":2}
{"level":"info","ts":"2026-04-19T11:15:10.405324Z","caller":"traceutil/trace.go:171","msg":"trace[1226222937] transaction","detail":"{read_only:false; response_revision:5263; number_of_response:1; }","duration":"223.926523ms","start":"2026-04-19T11:15:10.181381Z","end":"2026-04-19T11:15:10.405308Z","steps":["trace[1226222937] 'process raft request'  (duration: 93.210216ms)","trace[1226222937] 'compare'  (duration: 130.228516ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-19T11:15:10.40551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.545511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-04-19T11:15:10.405595Z","caller":"traceutil/trace.go:171","msg":"trace[2034626544] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5263; }","duration":"124.686654ms","start":"2026-04-19T11:15:10.280889Z","end":"2026-04-19T11:15:10.405575Z","steps":["trace[2034626544] 'agreement among raft nodes before linearized reading'  (duration: 124.460549ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:15:10.405635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.806383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-04-19T11:15:10.405709Z","caller":"traceutil/trace.go:171","msg":"trace[755765160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5263; }","duration":"168.880495ms","start":"2026-04-19T11:15:10.236811Z","end":"2026-04-19T11:15:10.405691Z","steps":["trace[755765160] 'agreement among raft nodes before linearized reading'  (duration: 168.707591ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:15:10.405769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.10261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-04-19T11:15:10.405872Z","caller":"traceutil/trace.go:171","msg":"trace[1922158339] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5263; }","duration":"119.263104ms","start":"2026-04-19T11:15:10.286584Z","end":"2026-04-19T11:15:10.405847Z","steps":["trace[1922158339] 'agreement among raft nodes before linearized reading'  (duration: 118.930427ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:15:22.104674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.0624ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4241156807895422711 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5426 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-19T11:15:22.104812Z","caller":"traceutil/trace.go:171","msg":"trace[286235359] linearizableReadLoop","detail":"{readStateIndex:5638; appliedIndex:5637; }","duration":"260.895479ms","start":"2026-04-19T11:15:21.843894Z","end":"2026-04-19T11:15:22.104789Z","steps":["trace[286235359] 'read index received'  (duration: 89.634555ms)","trace[286235359] 'applied index is now lower than readState.Index'  (duration: 171.259364ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-19T11:15:22.105217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.319369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-19T11:15:22.105259Z","caller":"traceutil/trace.go:171","msg":"trace[748536178] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:5440; }","duration":"261.410911ms","start":"2026-04-19T11:15:21.843837Z","end":"2026-04-19T11:15:22.105247Z","steps":["trace[748536178] 'agreement among raft nodes before linearized reading'  (duration: 261.007293ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:15:22.105249Z","caller":"traceutil/trace.go:171","msg":"trace[1234551277] transaction","detail":"{read_only:false; response_revision:5440; number_of_response:1; }","duration":"367.543108ms","start":"2026-04-19T11:15:21.737678Z","end":"2026-04-19T11:15:22.105222Z","steps":["trace[1234551277] 'process raft request'  (duration: 195.820833ms)","trace[1234551277] 'compare'  (duration: 170.844626ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-19T11:15:22.105586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:15:21.737653Z","time spent":"367.867535ms","remote":"127.0.0.1:42978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5426 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-04-19T11:15:22.290172Z","caller":"traceutil/trace.go:171","msg":"trace[1751392053] transaction","detail":"{read_only:false; response_revision:5442; number_of_response:1; }","duration":"132.058355ms","start":"2026-04-19T11:15:22.158071Z","end":"2026-04-19T11:15:22.290129Z","steps":["trace[1751392053] 'process raft request'  (duration: 131.84059ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:15:22.34345Z","caller":"traceutil/trace.go:171","msg":"trace[495791237] transaction","detail":"{read_only:false; response_revision:5443; number_of_response:1; }","duration":"132.662068ms","start":"2026-04-19T11:15:22.21076Z","end":"2026-04-19T11:15:22.343422Z","steps":["trace[495791237] 'process raft request'  (duration: 132.509725ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:15:22.443114Z","caller":"traceutil/trace.go:171","msg":"trace[1525536145] transaction","detail":"{read_only:false; response_revision:5444; number_of_response:1; }","duration":"146.436532ms","start":"2026-04-19T11:15:22.296642Z","end":"2026-04-19T11:15:22.443078Z","steps":["trace[1525536145] 'process raft request'  (duration: 95.028514ms)","trace[1525536145] 'compare'  (duration: 51.192093ms)"],"step_count":2}
{"level":"info","ts":"2026-04-19T11:15:22.443285Z","caller":"traceutil/trace.go:171","msg":"trace[1811531635] transaction","detail":"{read_only:false; response_revision:5445; number_of_response:1; }","duration":"145.808146ms","start":"2026-04-19T11:15:22.297444Z","end":"2026-04-19T11:15:22.443252Z","steps":["trace[1811531635] 'process raft request'  (duration: 145.551881ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:15:22.443397Z","caller":"traceutil/trace.go:171","msg":"trace[423298292] transaction","detail":"{read_only:false; response_revision:5446; number_of_response:1; }","duration":"145.932229ms","start":"2026-04-19T11:15:22.297444Z","end":"2026-04-19T11:15:22.443377Z","steps":["trace[423298292] 'process raft request'  (duration: 145.709194ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:15:22.443546Z","caller":"traceutil/trace.go:171","msg":"trace[291206422] transaction","detail":"{read_only:false; response_revision:5447; number_of_response:1; }","duration":"144.724563ms","start":"2026-04-19T11:15:22.2988Z","end":"2026-04-19T11:15:22.443525Z","steps":["trace[291206422] 'process raft request'  (duration: 144.486298ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:16:09.163505Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2823}
{"level":"info","ts":"2026-04-19T11:16:09.243193Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2823,"took":"77.598042ms","hash":877120109,"current-db-size-bytes":57692160,"current-db-size":"58 MB","current-db-size-in-use-bytes":32534528,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-04-19T11:16:09.243301Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":877120109,"revision":2823,"compact-revision":-1}
{"level":"info","ts":"2026-04-19T11:21:09.228422Z","caller":"traceutil/trace.go:171","msg":"trace[246572471] transaction","detail":"{read_only:false; response_revision:8089; number_of_response:1; }","duration":"135.599653ms","start":"2026-04-19T11:21:09.092787Z","end":"2026-04-19T11:21:09.228387Z","steps":["trace[246572471] 'process raft request'  (duration: 87.676226ms)","trace[246572471] 'compare'  (duration: 47.646781ms)"],"step_count":2}
{"level":"info","ts":"2026-04-19T11:21:09.232611Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5865}
{"level":"info","ts":"2026-04-19T11:21:09.314464Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5865,"took":"80.048369ms","hash":3773888516,"current-db-size-bytes":57692160,"current-db-size":"58 MB","current-db-size-in-use-bytes":26583040,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-04-19T11:21:09.314537Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3773888516,"revision":5865,"compact-revision":2823}
{"level":"warn","ts":"2026-04-19T11:21:21.011105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.521831ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4241156807895430176 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8140 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-19T11:21:21.011231Z","caller":"traceutil/trace.go:171","msg":"trace[982985925] linearizableReadLoop","detail":"{readStateIndex:8436; appliedIndex:8435; }","duration":"377.348936ms","start":"2026-04-19T11:21:20.633863Z","end":"2026-04-19T11:21:21.011212Z","steps":["trace[982985925] 'read index received'  (duration: 268.548888ms)","trace[982985925] 'applied index is now lower than readState.Index'  (duration: 108.799298ms)"],"step_count":2}
{"level":"info","ts":"2026-04-19T11:21:21.011295Z","caller":"traceutil/trace.go:171","msg":"trace[1716599232] transaction","detail":"{read_only:false; response_revision:8151; number_of_response:1; }","duration":"377.947488ms","start":"2026-04-19T11:21:20.633341Z","end":"2026-04-19T11:21:21.011288Z","steps":["trace[1716599232] 'process raft request'  (duration: 269.160911ms)","trace[1716599232] 'compare'  (duration: 108.43804ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-19T11:21:21.011332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:21:20.633319Z","time spent":"377.995469ms","remote":"127.0.0.1:42978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8140 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-04-19T11:21:21.011631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.67483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-19T11:21:21.011657Z","caller":"traceutil/trace.go:171","msg":"trace[1821483007] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:8151; }","duration":"144.737022ms","start":"2026-04-19T11:21:20.866913Z","end":"2026-04-19T11:21:21.01165Z","steps":["trace[1821483007] 'agreement among raft nodes before linearized reading'  (duration: 144.681631ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:21:21.015207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.487939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-19T11:21:21.015345Z","caller":"traceutil/trace.go:171","msg":"trace[397426782] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:8151; }","duration":"102.648193ms","start":"2026-04-19T11:21:20.912673Z","end":"2026-04-19T11:21:21.015321Z","steps":["trace[397426782] 'agreement among raft nodes before linearized reading'  (duration: 102.471218ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:21:21.015414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.202333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-19T11:21:21.015558Z","caller":"traceutil/trace.go:171","msg":"trace[2073438849] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:8151; }","duration":"118.471639ms","start":"2026-04-19T11:21:20.897052Z","end":"2026-04-19T11:21:21.015524Z","steps":["trace[2073438849] 'agreement among raft nodes before linearized reading'  (duration: 118.028449ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:21:21.016037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.641963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-19T11:21:21.016102Z","caller":"traceutil/trace.go:171","msg":"trace[1676453881] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:8151; }","duration":"102.718975ms","start":"2026-04-19T11:21:20.913369Z","end":"2026-04-19T11:21:21.016088Z","steps":["trace[1676453881] 'agreement among raft nodes before linearized reading'  (duration: 102.626983ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:21:21.016559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.88623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-19T11:21:21.016622Z","caller":"traceutil/trace.go:171","msg":"trace[885496979] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:8151; }","duration":"103.967942ms","start":"2026-04-19T11:21:20.912637Z","end":"2026-04-19T11:21:21.016605Z","steps":["trace[885496979] 'agreement among raft nodes before linearized reading'  (duration: 103.856279ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:21:21.016959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.013309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-19T11:21:21.01699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.981436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-19T11:21:21.017362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.49177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"warn","ts":"2026-04-19T11:21:21.017355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.682147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-19T11:21:21.017524Z","caller":"traceutil/trace.go:171","msg":"trace[1627863524] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:8151; }","duration":"120.870531ms","start":"2026-04-19T11:21:20.896599Z","end":"2026-04-19T11:21:21.017469Z","steps":["trace[1627863524] 'agreement among raft nodes before linearized reading'  (duration: 120.631146ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:21:21.017424Z","caller":"traceutil/trace.go:171","msg":"trace[110155839] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8151; }","duration":"383.557361ms","start":"2026-04-19T11:21:20.633845Z","end":"2026-04-19T11:21:21.017402Z","steps":["trace[110155839] 'agreement among raft nodes before linearized reading'  (duration: 377.950678ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:21:21.017685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:21:20.633836Z","time spent":"383.825206ms","remote":"127.0.0.1:42920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-04-19T11:21:21.017716Z","caller":"traceutil/trace.go:171","msg":"trace[940844598] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:8151; }","duration":"150.642251ms","start":"2026-04-19T11:21:20.866981Z","end":"2026-04-19T11:21:21.017623Z","steps":["trace[940844598] 'agreement among raft nodes before linearized reading'  (duration: 149.957066ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:21:21.017724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.722892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-19T11:21:21.017012Z","caller":"traceutil/trace.go:171","msg":"trace[1949350135] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:8151; }","duration":"113.118701ms","start":"2026-04-19T11:21:20.903879Z","end":"2026-04-19T11:21:21.016997Z","steps":["trace[1949350135] 'agreement among raft nodes before linearized reading'  (duration: 113.021799ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:21:21.017838Z","caller":"traceutil/trace.go:171","msg":"trace[590874909] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:8151; }","duration":"150.802494ms","start":"2026-04-19T11:21:20.866964Z","end":"2026-04-19T11:21:21.017767Z","steps":["trace[590874909] 'agreement among raft nodes before linearized reading'  (duration: 150.706132ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:21:21.017744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.239259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-19T11:21:21.01792Z","caller":"traceutil/trace.go:171","msg":"trace[1755005879] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:8151; }","duration":"121.431113ms","start":"2026-04-19T11:21:20.896447Z","end":"2026-04-19T11:21:21.017878Z","steps":["trace[1755005879] 'agreement among raft nodes before linearized reading'  (duration: 121.228119ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:21:21.898861Z","caller":"traceutil/trace.go:171","msg":"trace[1368124701] linearizableReadLoop","detail":"{readStateIndex:8439; appliedIndex:8438; }","duration":"279.452476ms","start":"2026-04-19T11:21:21.619378Z","end":"2026-04-19T11:21:21.898831Z","steps":["trace[1368124701] 'read index received'  (duration: 202.985366ms)","trace[1368124701] 'applied index is now lower than readState.Index'  (duration: 76.46626ms)"],"step_count":2}
{"level":"info","ts":"2026-04-19T11:21:21.898975Z","caller":"traceutil/trace.go:171","msg":"trace[996762821] transaction","detail":"{read_only:false; response_revision:8154; number_of_response:1; }","duration":"390.257787ms","start":"2026-04-19T11:21:21.508657Z","end":"2026-04-19T11:21:21.898915Z","steps":["trace[996762821] 'process raft request'  (duration: 313.789256ms)","trace[996762821] 'compare'  (duration: 76.152384ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-19T11:21:21.89914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.751683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"}
{"level":"info","ts":"2026-04-19T11:21:21.899177Z","caller":"traceutil/trace.go:171","msg":"trace[1959354405] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8154; }","duration":"279.868405ms","start":"2026-04-19T11:21:21.619299Z","end":"2026-04-19T11:21:21.899167Z","steps":["trace[1959354405] 'agreement among raft nodes before linearized reading'  (duration: 279.704692ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:21:21.899233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:21:21.508634Z","time spent":"390.454611ms","remote":"127.0.0.1:42978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8144 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-19T11:21:21.89951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.165473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-b7bxs\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-04-19T11:21:21.899809Z","caller":"traceutil/trace.go:171","msg":"trace[887797869] range","detail":"{range_begin:/registry/pods/openstack/keepalived-b7bxs; range_end:; response_count:1; response_revision:8154; }","duration":"151.331617ms","start":"2026-04-19T11:21:21.748267Z","end":"2026-04-19T11:21:21.899599Z","steps":["trace[887797869] 'agreement among raft nodes before linearized reading'  (duration: 150.831486ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:21:22.113112Z","caller":"traceutil/trace.go:171","msg":"trace[56156114] transaction","detail":"{read_only:false; response_revision:8156; number_of_response:1; }","duration":"104.616835ms","start":"2026-04-19T11:21:22.008461Z","end":"2026-04-19T11:21:22.113078Z","steps":["trace[56156114] 'process raft request'  (duration: 104.345709ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:21:50.208229Z","caller":"traceutil/trace.go:171","msg":"trace[531119246] linearizableReadLoop","detail":"{readStateIndex:8650; appliedIndex:8649; }","duration":"127.594229ms","start":"2026-04-19T11:21:50.080599Z","end":"2026-04-19T11:21:50.208193Z","steps":["trace[531119246] 'read index received'  (duration: 127.316043ms)","trace[531119246] 'applied index is now lower than readState.Index'  (duration: 276.806µs)"],"step_count":2}
{"level":"info","ts":"2026-04-19T11:21:50.208304Z","caller":"traceutil/trace.go:171","msg":"trace[1514970750] transaction","detail":"{read_only:false; response_revision:8358; number_of_response:1; }","duration":"193.297086ms","start":"2026-04-19T11:21:50.014931Z","end":"2026-04-19T11:21:50.208228Z","steps":["trace[1514970750] 'process raft request'  (duration: 193.043311ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:21:50.208641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.978998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"info","ts":"2026-04-19T11:21:50.208776Z","caller":"traceutil/trace.go:171","msg":"trace[2114445738] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8358; }","duration":"128.216523ms","start":"2026-04-19T11:21:50.080536Z","end":"2026-04-19T11:21:50.208752Z","steps":["trace[2114445738] 'agreement among raft nodes before linearized reading'  (duration: 127.840595ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:21:50.390239Z","caller":"traceutil/trace.go:171","msg":"trace[1325924557] linearizableReadLoop","detail":"{readStateIndex:8651; appliedIndex:8650; }","duration":"174.431763ms","start":"2026-04-19T11:21:50.215779Z","end":"2026-04-19T11:21:50.390211Z","steps":["trace[1325924557] 'read index received'  (duration: 174.214468ms)","trace[1325924557] 'applied index is now lower than readState.Index'  (duration: 216.105µs)"],"step_count":2}
{"level":"info","ts":"2026-04-19T11:21:50.390341Z","caller":"traceutil/trace.go:171","msg":"trace[261561118] transaction","detail":"{read_only:false; response_revision:8359; number_of_response:1; }","duration":"175.725531ms","start":"2026-04-19T11:21:50.214563Z","end":"2026-04-19T11:21:50.390289Z","steps":["trace[261561118] 'process raft request'  (duration: 175.454825ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:21:50.390812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.014467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:211781"}
{"level":"info","ts":"2026-04-19T11:21:50.390881Z","caller":"traceutil/trace.go:171","msg":"trace[1300759606] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8359; }","duration":"175.14478ms","start":"2026-04-19T11:21:50.215722Z","end":"2026-04-19T11:21:50.390867Z","steps":["trace[1300759606] 'agreement among raft nodes before linearized reading'  (duration: 174.602077ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:22:03.690546Z","caller":"traceutil/trace.go:171","msg":"trace[742897584] transaction","detail":"{read_only:false; response_revision:8476; number_of_response:1; }","duration":"139.05142ms","start":"2026-04-19T11:22:03.551467Z","end":"2026-04-19T11:22:03.690519Z","steps":["trace[742897584] 'process raft request'  (duration: 138.794734ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:22:03.793858Z","caller":"traceutil/trace.go:171","msg":"trace[1356713042] transaction","detail":"{read_only:false; response_revision:8477; number_of_response:1; }","duration":"227.435362ms","start":"2026-04-19T11:22:03.566396Z","end":"2026-04-19T11:22:03.793831Z","steps":["trace[1356713042] 'process raft request'  (duration: 219.876457ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:22:03.794005Z","caller":"traceutil/trace.go:171","msg":"trace[690090201] linearizableReadLoop","detail":"{readStateIndex:8776; appliedIndex:8774; }","duration":"218.354824ms","start":"2026-04-19T11:22:03.575634Z","end":"2026-04-19T11:22:03.793988Z","steps":["trace[690090201] 'read index received'  (duration: 114.80655ms)","trace[690090201] 'applied index is now lower than readState.Index'  (duration: 103.546804ms)"],"step_count":2}
{"level":"info","ts":"2026-04-19T11:22:03.794212Z","caller":"traceutil/trace.go:171","msg":"trace[790372663] transaction","detail":"{read_only:false; response_revision:8478; number_of_response:1; }","duration":"143.478577ms","start":"2026-04-19T11:22:03.650725Z","end":"2026-04-19T11:22:03.794203Z","steps":["trace[790372663] 'process raft request'  (duration: 143.044448ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:22:03.794347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.692551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-04-19T11:22:03.794407Z","caller":"traceutil/trace.go:171","msg":"trace[799777463] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8478; }","duration":"218.801833ms","start":"2026-04-19T11:22:03.575589Z","end":"2026-04-19T11:22:03.794391Z","steps":["trace[799777463] 'agreement among raft nodes before linearized reading'  (duration: 218.701951ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:22:04.792597Z","caller":"traceutil/trace.go:171","msg":"trace[1409810802] linearizableReadLoop","detail":"{readStateIndex:8782; appliedIndex:8781; }","duration":"303.336682ms","start":"2026-04-19T11:22:04.48922Z","end":"2026-04-19T11:22:04.792557Z","steps":["trace[1409810802] 'read index received'  (duration: 294.720284ms)","trace[1409810802] 'applied index is now lower than readState.Index'  (duration: 8.615238ms)"],"step_count":2}
{"level":"info","ts":"2026-04-19T11:22:04.792697Z","caller":"traceutil/trace.go:171","msg":"trace[1702461596] transaction","detail":"{read_only:false; response_revision:8483; number_of_response:1; }","duration":"303.861414ms","start":"2026-04-19T11:22:04.488765Z","end":"2026-04-19T11:22:04.792627Z","steps":["trace[1702461596] 'process raft request'  (duration: 295.121203ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:22:04.792893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.65282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-config-override\" ","response":"range_response_count:1 size:1097"}
{"level":"info","ts":"2026-04-19T11:22:04.793002Z","caller":"traceutil/trace.go:171","msg":"trace[1047467378] range","detail":"{range_begin:/registry/configmaps/openstack/rook-config-override; range_end:; response_count:1; response_revision:8483; }","duration":"303.818553ms","start":"2026-04-19T11:22:04.489158Z","end":"2026-04-19T11:22:04.792977Z","steps":["trace[1047467378] 'agreement among raft nodes before linearized reading'  (duration: 303.545048ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:22:04.793051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:22:04.489132Z","time spent":"303.911225ms","remote":"127.0.0.1:42836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":1120,"request content":"key:\"/registry/configmaps/openstack/rook-config-override\" "}
{"level":"warn","ts":"2026-04-19T11:22:04.793223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.615655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:211696"}
{"level":"info","ts":"2026-04-19T11:22:04.793277Z","caller":"traceutil/trace.go:171","msg":"trace[1202416887] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8483; }","duration":"301.720987ms","start":"2026-04-19T11:22:04.491545Z","end":"2026-04-19T11:22:04.793266Z","steps":["trace[1202416887] 'agreement among raft nodes before linearized reading'  (duration: 301.187125ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-19T11:22:04.792917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:22:04.488746Z","time spent":"304.066888ms","remote":"127.0.0.1:42978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8458 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-19T11:22:04.793319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:22:04.491529Z","time spent":"301.780249ms","remote":"127.0.0.1:42920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":25,"response size":211719,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"info","ts":"2026-04-19T11:22:55.074805Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002464.wal"}
{"level":"warn","ts":"2026-04-19T11:23:12.670789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.949877ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4241156807895433088 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:9107 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-19T11:23:12.670919Z","caller":"traceutil/trace.go:171","msg":"trace[725365311] linearizableReadLoop","detail":"{readStateIndex:9436; appliedIndex:9435; }","duration":"129.962409ms","start":"2026-04-19T11:23:12.540938Z","end":"2026-04-19T11:23:12.670901Z","steps":["trace[725365311] 'read index received'  (duration: 12.852379ms)","trace[725365311] 'applied index is now lower than readState.Index'  (duration: 117.10849ms)"],"step_count":2}
{"level":"info","ts":"2026-04-19T11:23:12.670934Z","caller":"traceutil/trace.go:171","msg":"trace[10572082] transaction","detail":"{read_only:false; response_revision:9118; number_of_response:1; }","duration":"143.068916ms","start":"2026-04-19T11:23:12.527843Z","end":"2026-04-19T11:23:12.670912Z","steps":["trace[10572082] 'process raft request'  (duration: 25.898034ms)","trace[10572082] 'compare'  (duration: 116.814814ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-19T11:23:12.671118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.174334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-04-19T11:23:12.67116Z","caller":"traceutil/trace.go:171","msg":"trace[1814039414] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:9118; }","duration":"130.245456ms","start":"2026-04-19T11:23:12.540902Z","end":"2026-04-19T11:23:12.671148Z","steps":["trace[1814039414] 'agreement among raft nodes before linearized reading'  (duration: 130.095922ms)"],"step_count":1}
{"level":"info","ts":"2026-04-19T11:24:16.099356Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"2062be27cfb43adb","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-04-19T11:24:16.104881Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-04-19T11:24:16.105049Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-04-19T11:26:09.240036Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8090}
{"level":"info","ts":"2026-04-19T11:26:09.307668Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8090,"took":"64.959322ms","hash":3370226072,"current-db-size-bytes":57692160,"current-db-size":"58 MB","current-db-size-in-use-bytes":29261824,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-04-19T11:26:09.307746Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3370226072,"revision":8090,"compact-revision":5865}
{"level":"info","ts":"2026-04-19T11:31:09.24625Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10525}
{"level":"info","ts":"2026-04-19T11:31:09.332382Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10525,"took":"83.028755ms","hash":510141680,"current-db-size-bytes":57692160,"current-db-size":"58 MB","current-db-size-in-use-bytes":20099072,"current-db-size-in-use":"20 MB"}
{"level":"info","ts":"2026-04-19T11:31:09.332455Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":510141680,"revision":10525,"compact-revision":8090}