{"level":"warn","ts":"2026-05-01T14:04:53.418526Z","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-01T14:04:53.418606Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.115:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.115:2380","--initial-cluster=instance=https://199.204.45.115:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.115:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.115:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-05-01T14:04:53.418665Z","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-01T14:04:53.418674Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.115:2380"]}
{"level":"info","ts":"2026-05-01T14:04:53.418693Z","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-01T14:04:53.419339Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"]}
{"level":"info","ts":"2026-05-01T14:04:53.41942Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.115:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-05-01T14:04:53.422993Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.310503ms"}
{"level":"info","ts":"2026-05-01T14:04:53.431994Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3aaa5c123e150e0","cluster-id":"61ec519698823541"}
{"level":"info","ts":"2026-05-01T14:04:53.432093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-01T14:04:53.43212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 0"}
{"level":"info","ts":"2026-05-01T14:04:53.432143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3aaa5c123e150e0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-01T14:04:53.432165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 1"}
{"level":"info","ts":"2026-05-01T14:04:53.43222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"}
{"level":"warn","ts":"2026-05-01T14:04:53.437802Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-01T14:04:53.439437Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-01T14:04:53.442455Z","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-01T14:04:53.445294Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3aaa5c123e150e0","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-01T14:04:53.446295Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3aaa5c123e150e0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-01T14:04:53.447793Z","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-01T14:04:53.447891Z","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-01T14:04:53.447916Z","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-01T14:04:53.449513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"}
{"level":"info","ts":"2026-05-01T14:04:53.450073Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","added-peer-id":"e3aaa5c123e150e0","added-peer-peer-urls":["https://199.204.45.115:2380"]}
{"level":"info","ts":"2026-05-01T14:04:53.451762Z","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-01T14:04:53.451803Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.115:2380"}
{"level":"info","ts":"2026-05-01T14:04:53.451837Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.115:2380"}
{"level":"info","ts":"2026-05-01T14:04:53.45224Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3aaa5c123e150e0","initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-01T14:04:53.452281Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-01T14:04:53.833141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-01T14:04:53.833219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-01T14:04:53.833266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgPreVoteResp from e3aaa5c123e150e0 at term 1"}
{"level":"info","ts":"2026-05-01T14:04:53.833288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became candidate at term 2"}
{"level":"info","ts":"2026-05-01T14:04:53.833299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgVoteResp from e3aaa5c123e150e0 at term 2"}
{"level":"info","ts":"2026-05-01T14:04:53.833317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became leader at term 2"}
{"level":"info","ts":"2026-05-01T14:04:53.833339Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3aaa5c123e150e0 elected leader e3aaa5c123e150e0 at term 2"}
{"level":"info","ts":"2026-05-01T14:04:53.835683Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3aaa5c123e150e0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.115:2379]}","request-path":"/0/members/e3aaa5c123e150e0/attributes","cluster-id":"61ec519698823541","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-01T14:04:53.835798Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-01T14:04:53.835892Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-01T14:04:53.836075Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-01T14:04:53.836231Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-01T14:04:53.836254Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-01T14:04:53.836566Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-01T14:04:53.83668Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-01T14:04:53.836731Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-01T14:04:53.83966Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-01T14:04:53.852765Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.115:2379"}
{"level":"info","ts":"2026-05-01T14:05:07.940904Z","caller":"traceutil/trace.go:171","msg":"trace[748085953] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"342.362447ms","start":"2026-05-01T14:05:07.598511Z","end":"2026-05-01T14:05:07.940873Z","steps":["trace[748085953] 'process raft request'  (duration: 342.201525ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:05:07.940868Z","caller":"traceutil/trace.go:171","msg":"trace[324486650] linearizableReadLoop","detail":"{readStateIndex:380; appliedIndex:379; }","duration":"305.318343ms","start":"2026-05-01T14:05:07.635527Z","end":"2026-05-01T14:05:07.940845Z","steps":["trace[324486650] 'read index received'  (duration: 305.17758ms)","trace[324486650] 'applied index is now lower than readState.Index'  (duration: 139.543µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-01T14:05:07.941105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.488106ms","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-01T14:05:07.941293Z","caller":"traceutil/trace.go:171","msg":"trace[1080091187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:366; }","duration":"305.73061ms","start":"2026-05-01T14:05:07.635519Z","end":"2026-05-01T14:05:07.94125Z","steps":["trace[1080091187] 'agreement among raft nodes before linearized reading'  (duration: 305.443175ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:05:07.941359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:05:07.598485Z","time spent":"342.49591ms","remote":"127.0.0.1:51364","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:355 > 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-05-01T14:05:07.941398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:05:07.635485Z","time spent":"305.897583ms","remote":"127.0.0.1:51364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-05-01T14:05:18.182396Z","caller":"traceutil/trace.go:171","msg":"trace[1639367034] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"197.911142ms","start":"2026-05-01T14:05:17.984462Z","end":"2026-05-01T14:05:18.182374Z","steps":["trace[1639367034] 'process raft request'  (duration: 197.79688ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:05:18.351644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.341652ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827831519779830730 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:415 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-01T14:05:18.351712Z","caller":"traceutil/trace.go:171","msg":"trace[197805713] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"365.243765ms","start":"2026-05-01T14:05:17.986457Z","end":"2026-05-01T14:05:18.351701Z","steps":["trace[197805713] 'process raft request'  (duration: 231.681529ms)","trace[197805713] 'compare'  (duration: 133.260791ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-01T14:05:18.351745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:05:17.986444Z","time spent":"365.287035ms","remote":"127.0.0.1:51364","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:415 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-01T14:05:35.23609Z","caller":"traceutil/trace.go:171","msg":"trace[2111304378] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"250.553515ms","start":"2026-05-01T14:05:34.98547Z","end":"2026-05-01T14:05:35.236023Z","steps":["trace[2111304378] 'process raft request'  (duration: 250.315501ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:07:11.639529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.802665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-91ec7ef5-2e89-4061-a558-d0da9a4772df\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-05-01T14:07:11.639641Z","caller":"traceutil/trace.go:171","msg":"trace[1927453875] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"172.245809ms","start":"2026-05-01T14:07:11.467323Z","end":"2026-05-01T14:07:11.639569Z","steps":["trace[1927453875] 'process raft request'  (duration: 103.142967ms)","trace[1927453875] 'compare'  (duration: 68.898285ms)"],"step_count":2}
{"level":"info","ts":"2026-05-01T14:07:11.639668Z","caller":"traceutil/trace.go:171","msg":"trace[1598071776] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-91ec7ef5-2e89-4061-a558-d0da9a4772df; range_end:; response_count:1; response_revision:1826; }","duration":"199.95346ms","start":"2026-05-01T14:07:11.439697Z","end":"2026-05-01T14:07:11.63965Z","steps":["trace[1598071776] 'range keys from in-memory index tree'  (duration: 199.573668ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:07:11.87485Z","caller":"traceutil/trace.go:171","msg":"trace[1100421344] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"150.985885ms","start":"2026-05-01T14:07:11.723835Z","end":"2026-05-01T14:07:11.874821Z","steps":["trace[1100421344] 'process raft request'  (duration: 79.234148ms)","trace[1100421344] 'compare'  (duration: 71.477998ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-01T14:07:12.100352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.038181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-05-01T14:07:12.100436Z","caller":"traceutil/trace.go:171","msg":"trace[787784743] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1830; }","duration":"111.166494ms","start":"2026-05-01T14:07:11.989251Z","end":"2026-05-01T14:07:12.100417Z","steps":["trace[787784743] 'range keys from in-memory index tree'  (duration: 110.895056ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:07:46.430686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.952738ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827831519779834093 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/percona-xtradb-pxc-0.18ab76393a193f06\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/percona-xtradb-pxc-0.18ab76393a193f06\" value_size:738 lease:5827831519779833177 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-01T14:07:46.430887Z","caller":"traceutil/trace.go:171","msg":"trace[1948680003] linearizableReadLoop","detail":"{readStateIndex:2155; appliedIndex:2153; }","duration":"215.196999ms","start":"2026-05-01T14:07:46.215673Z","end":"2026-05-01T14:07:46.43087Z","steps":["trace[1948680003] 'read index received'  (duration: 81.948002ms)","trace[1948680003] 'applied index is now lower than readState.Index'  (duration: 133.247917ms)"],"step_count":2}
{"level":"info","ts":"2026-05-01T14:07:46.430975Z","caller":"traceutil/trace.go:171","msg":"trace[440732083] transaction","detail":"{read_only:false; response_revision:2071; number_of_response:1; }","duration":"340.963228ms","start":"2026-05-01T14:07:46.09Z","end":"2026-05-01T14:07:46.430963Z","steps":["trace[440732083] 'process raft request'  (duration: 207.66208ms)","trace[440732083] 'compare'  (duration: 132.560947ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-01T14:07:46.431031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:07:46.089988Z","time spent":"341.017019ms","remote":"127.0.0.1:51196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":820,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/openstack/percona-xtradb-pxc-0.18ab76393a193f06\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/percona-xtradb-pxc-0.18ab76393a193f06\" value_size:738 lease:5827831519779833177 >> failure:<>"}
{"level":"warn","ts":"2026-05-01T14:07:46.431345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.681392ms","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":"warn","ts":"2026-05-01T14:07:46.431411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.055053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-05-01T14:07:46.431446Z","caller":"traceutil/trace.go:171","msg":"trace[394846237] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2072; }","duration":"215.827036ms","start":"2026-05-01T14:07:46.215597Z","end":"2026-05-01T14:07:46.431424Z","steps":["trace[394846237] 'agreement among raft nodes before linearized reading'  (duration: 215.486337ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:07:46.431549Z","caller":"traceutil/trace.go:171","msg":"trace[774434788] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2072; }","duration":"166.193316ms","start":"2026-05-01T14:07:46.265295Z","end":"2026-05-01T14:07:46.431488Z","steps":["trace[774434788] 'agreement among raft nodes before linearized reading'  (duration: 165.981431ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:07:46.431345Z","caller":"traceutil/trace.go:171","msg":"trace[559983574] transaction","detail":"{read_only:false; response_revision:2072; number_of_response:1; }","duration":"340.914226ms","start":"2026-05-01T14:07:46.090391Z","end":"2026-05-01T14:07:46.431305Z","steps":["trace[559983574] 'process raft request'  (duration: 340.412643ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:07:46.431956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:07:46.090375Z","time spent":"341.473811ms","remote":"127.0.0.1:51364","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2061 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-05-01T14:07:46.432485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.915595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-01T14:07:46.432626Z","caller":"traceutil/trace.go:171","msg":"trace[1900072913] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2072; }","duration":"178.081788ms","start":"2026-05-01T14:07:46.25452Z","end":"2026-05-01T14:07:46.432602Z","steps":["trace[1900072913] 'agreement among raft nodes before linearized reading'  (duration: 176.667291ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:07:46.712982Z","caller":"traceutil/trace.go:171","msg":"trace[776085195] transaction","detail":"{read_only:false; response_revision:2074; number_of_response:1; }","duration":"276.511676ms","start":"2026-05-01T14:07:46.436436Z","end":"2026-05-01T14:07:46.712948Z","steps":["trace[776085195] 'process raft request'  (duration: 275.750666ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:07:46.713985Z","caller":"traceutil/trace.go:171","msg":"trace[1315040328] transaction","detail":"{read_only:false; response_revision:2075; number_of_response:1; }","duration":"205.089573ms","start":"2026-05-01T14:07:46.508868Z","end":"2026-05-01T14:07:46.713957Z","steps":["trace[1315040328] 'process raft request'  (duration: 204.97112ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:08:51.034827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.970354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-01T14:08:51.03495Z","caller":"traceutil/trace.go:171","msg":"trace[1088244176] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2524; }","duration":"139.121477ms","start":"2026-05-01T14:08:50.89579Z","end":"2026-05-01T14:08:51.034911Z","steps":["trace[1088244176] 'range keys from in-memory index tree'  (duration: 138.863351ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:08:51.052739Z","caller":"traceutil/trace.go:171","msg":"trace[72463531] transaction","detail":"{read_only:false; response_revision:2525; number_of_response:1; }","duration":"136.534569ms","start":"2026-05-01T14:08:50.916189Z","end":"2026-05-01T14:08:51.052724Z","steps":["trace[72463531] 'process raft request'  (duration: 136.393267ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:09:23.44821Z","caller":"traceutil/trace.go:171","msg":"trace[1357825637] transaction","detail":"{read_only:false; response_revision:2704; number_of_response:1; }","duration":"119.971758ms","start":"2026-05-01T14:09:23.328217Z","end":"2026-05-01T14:09:23.448189Z","steps":["trace[1357825637] 'process raft request'  (duration: 119.500658ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:09:23.801598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.64259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-05-01T14:09:23.801694Z","caller":"traceutil/trace.go:171","msg":"trace[114291990] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2705; }","duration":"192.786292ms","start":"2026-05-01T14:09:23.60888Z","end":"2026-05-01T14:09:23.801666Z","steps":["trace[114291990] 'range keys from in-memory index tree'  (duration: 191.868224ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:09:29.027651Z","caller":"traceutil/trace.go:171","msg":"trace[1515924222] transaction","detail":"{read_only:false; response_revision:2732; number_of_response:1; }","duration":"114.513653ms","start":"2026-05-01T14:09:28.913112Z","end":"2026-05-01T14:09:29.027626Z","steps":["trace[1515924222] 'process raft request'  (duration: 114.284048ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:13:11.511857Z","caller":"traceutil/trace.go:171","msg":"trace[1305120870] transaction","detail":"{read_only:false; response_revision:4550; number_of_response:1; }","duration":"110.363786ms","start":"2026-05-01T14:13:11.401442Z","end":"2026-05-01T14:13:11.511805Z","steps":["trace[1305120870] 'process raft request'  (duration: 110.002695ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:13:11.512021Z","caller":"traceutil/trace.go:171","msg":"trace[1736044917] transaction","detail":"{read_only:false; response_revision:4552; number_of_response:1; }","duration":"110.483009ms","start":"2026-05-01T14:13:11.4015Z","end":"2026-05-01T14:13:11.511983Z","steps":["trace[1736044917] 'process raft request'  (duration: 110.210191ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:13:11.512124Z","caller":"traceutil/trace.go:171","msg":"trace[1061752647] transaction","detail":"{read_only:false; response_revision:4556; number_of_response:1; }","duration":"101.826151ms","start":"2026-05-01T14:13:11.410281Z","end":"2026-05-01T14:13:11.512107Z","steps":["trace[1061752647] 'process raft request'  (duration: 101.655177ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:13:11.512313Z","caller":"traceutil/trace.go:171","msg":"trace[2110994246] transaction","detail":"{read_only:false; response_revision:4555; number_of_response:1; }","duration":"103.329ms","start":"2026-05-01T14:13:11.40891Z","end":"2026-05-01T14:13:11.512239Z","steps":["trace[2110994246] 'process raft request'  (duration: 102.979921ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:13:11.51232Z","caller":"traceutil/trace.go:171","msg":"trace[32198725] transaction","detail":"{read_only:false; response_revision:4551; number_of_response:1; }","duration":"110.757636ms","start":"2026-05-01T14:13:11.4015Z","end":"2026-05-01T14:13:11.512258Z","steps":["trace[32198725] 'process raft request'  (duration: 110.16583ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:13:11.512323Z","caller":"traceutil/trace.go:171","msg":"trace[142379647] transaction","detail":"{read_only:false; response_revision:4553; number_of_response:1; }","duration":"110.620852ms","start":"2026-05-01T14:13:11.401593Z","end":"2026-05-01T14:13:11.512214Z","steps":["trace[142379647] 'process raft request'  (duration: 110.150739ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:13:11.512438Z","caller":"traceutil/trace.go:171","msg":"trace[649548072] transaction","detail":"{read_only:false; response_revision:4554; number_of_response:1; }","duration":"103.963737ms","start":"2026-05-01T14:13:11.408459Z","end":"2026-05-01T14:13:11.512423Z","steps":["trace[649548072] 'process raft request'  (duration: 103.363291ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:13:11.512021Z","caller":"traceutil/trace.go:171","msg":"trace[1287821442] linearizableReadLoop","detail":"{readStateIndex:4731; appliedIndex:4726; }","duration":"103.68482ms","start":"2026-05-01T14:13:11.408316Z","end":"2026-05-01T14:13:11.512001Z","steps":["trace[1287821442] 'read index received'  (duration: 8.251578ms)","trace[1287821442] 'applied index is now lower than readState.Index'  (duration: 95.432262ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-01T14:13:11.512923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.576623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"}
{"level":"info","ts":"2026-05-01T14:13:11.512987Z","caller":"traceutil/trace.go:171","msg":"trace[342981739] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4556; }","duration":"104.678805ms","start":"2026-05-01T14:13:11.408288Z","end":"2026-05-01T14:13:11.512967Z","steps":["trace[342981739] 'agreement among raft nodes before linearized reading'  (duration: 104.392687ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:13:17.958698Z","caller":"traceutil/trace.go:171","msg":"trace[1226488477] transaction","detail":"{read_only:false; response_revision:4651; number_of_response:1; }","duration":"137.028173ms","start":"2026-05-01T14:13:17.821636Z","end":"2026-05-01T14:13:17.958664Z","steps":["trace[1226488477] 'process raft request'  (duration: 136.859009ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:13:18.470486Z","caller":"traceutil/trace.go:171","msg":"trace[437735249] linearizableReadLoop","detail":"{readStateIndex:4840; appliedIndex:4839; }","duration":"192.471662ms","start":"2026-05-01T14:13:18.277992Z","end":"2026-05-01T14:13:18.470464Z","steps":["trace[437735249] 'read index received'  (duration: 192.374489ms)","trace[437735249] 'applied index is now lower than readState.Index'  (duration: 95.953µs)"],"step_count":2}
{"level":"info","ts":"2026-05-01T14:13:18.470589Z","caller":"traceutil/trace.go:171","msg":"trace[894507816] transaction","detail":"{read_only:false; response_revision:4658; number_of_response:1; }","duration":"228.418198ms","start":"2026-05-01T14:13:18.242156Z","end":"2026-05-01T14:13:18.470574Z","steps":["trace[894507816] 'process raft request'  (duration: 228.15614ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:13:18.470872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.098307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-05-01T14:13:18.470712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.79163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-01T14:13:18.471149Z","caller":"traceutil/trace.go:171","msg":"trace[494824306] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:0; response_revision:4658; }","duration":"226.276442ms","start":"2026-05-01T14:13:18.244846Z","end":"2026-05-01T14:13:18.471123Z","steps":["trace[494824306] 'agreement among raft nodes before linearized reading'  (duration: 225.764589ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:13:18.471213Z","caller":"traceutil/trace.go:171","msg":"trace[2048599088] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4658; }","duration":"206.344243ms","start":"2026-05-01T14:13:18.264668Z","end":"2026-05-01T14:13:18.471012Z","steps":["trace[2048599088] 'agreement among raft nodes before linearized reading'  (duration: 205.845541ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:13:18.470749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.915477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-05-01T14:13:18.471329Z","caller":"traceutil/trace.go:171","msg":"trace[586287015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4658; }","duration":"230.532042ms","start":"2026-05-01T14:13:18.240782Z","end":"2026-05-01T14:13:18.471314Z","steps":["trace[586287015] 'agreement among raft nodes before linearized reading'  (duration: 229.838764ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:13:18.470826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.142457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-05-01T14:13:18.471457Z","caller":"traceutil/trace.go:171","msg":"trace[175623600] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4658; }","duration":"234.843356ms","start":"2026-05-01T14:13:18.236605Z","end":"2026-05-01T14:13:18.471448Z","steps":["trace[175623600] 'agreement among raft nodes before linearized reading'  (duration: 234.053595ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:13:18.537052Z","caller":"traceutil/trace.go:171","msg":"trace[1089785402] transaction","detail":"{read_only:false; response_revision:4659; number_of_response:1; }","duration":"173.011774ms","start":"2026-05-01T14:13:18.364021Z","end":"2026-05-01T14:13:18.537033Z","steps":["trace[1089785402] 'process raft request'  (duration: 172.86792ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:13:18.537247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.44902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-01T14:13:18.537527Z","caller":"traceutil/trace.go:171","msg":"trace[331312254] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:4659; }","duration":"139.609324ms","start":"2026-05-01T14:13:18.397709Z","end":"2026-05-01T14:13:18.537318Z","steps":["trace[331312254] 'agreement among raft nodes before linearized reading'  (duration: 139.405969ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:13:18.537986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.842492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"info","ts":"2026-05-01T14:13:18.538093Z","caller":"traceutil/trace.go:171","msg":"trace[505091384] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4659; }","duration":"255.997516ms","start":"2026-05-01T14:13:18.282074Z","end":"2026-05-01T14:13:18.538072Z","steps":["trace[505091384] 'agreement among raft nodes before linearized reading'  (duration: 255.158234ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:13:18.601027Z","caller":"traceutil/trace.go:171","msg":"trace[496645318] transaction","detail":"{read_only:false; response_revision:4660; number_of_response:1; }","duration":"121.040462ms","start":"2026-05-01T14:13:18.479962Z","end":"2026-05-01T14:13:18.601003Z","steps":["trace[496645318] 'process raft request'  (duration: 120.806606ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:13:18.601294Z","caller":"traceutil/trace.go:171","msg":"trace[1465020683] transaction","detail":"{read_only:false; response_revision:4661; number_of_response:1; }","duration":"121.303869ms","start":"2026-05-01T14:13:18.479966Z","end":"2026-05-01T14:13:18.60127Z","steps":["trace[1465020683] 'process raft request'  (duration: 120.97909ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:13:18.601794Z","caller":"traceutil/trace.go:171","msg":"trace[74137937] transaction","detail":"{read_only:false; response_revision:4662; number_of_response:1; }","duration":"121.75235ms","start":"2026-05-01T14:13:18.480022Z","end":"2026-05-01T14:13:18.601775Z","steps":["trace[74137937] 'process raft request'  (duration: 121.123043ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:13:18.601945Z","caller":"traceutil/trace.go:171","msg":"trace[1750580753] transaction","detail":"{read_only:false; response_revision:4663; number_of_response:1; }","duration":"121.913674ms","start":"2026-05-01T14:13:18.480018Z","end":"2026-05-01T14:13:18.601932Z","steps":["trace[1750580753] 'process raft request'  (duration: 121.675648ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:13:18.602041Z","caller":"traceutil/trace.go:171","msg":"trace[988199388] transaction","detail":"{read_only:false; response_revision:4665; number_of_response:1; }","duration":"121.931955ms","start":"2026-05-01T14:13:18.48009Z","end":"2026-05-01T14:13:18.602022Z","steps":["trace[988199388] 'process raft request'  (duration: 121.710549ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:13:18.602032Z","caller":"traceutil/trace.go:171","msg":"trace[1847409268] transaction","detail":"{read_only:false; response_revision:4664; number_of_response:1; }","duration":"121.955635ms","start":"2026-05-01T14:13:18.480044Z","end":"2026-05-01T14:13:18.602Z","steps":["trace[1847409268] 'process raft request'  (duration: 121.717729ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:13:18.602361Z","caller":"traceutil/trace.go:171","msg":"trace[1068774475] transaction","detail":"{read_only:false; response_revision:4666; number_of_response:1; }","duration":"122.249783ms","start":"2026-05-01T14:13:18.480094Z","end":"2026-05-01T14:13:18.602344Z","steps":["trace[1068774475] 'process raft request'  (duration: 121.747769ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:13:18.605279Z","caller":"traceutil/trace.go:171","msg":"trace[12229685] transaction","detail":"{read_only:false; response_revision:4667; number_of_response:1; }","duration":"125.162469ms","start":"2026-05-01T14:13:18.480097Z","end":"2026-05-01T14:13:18.605259Z","steps":["trace[12229685] 'process raft request'  (duration: 121.77425ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:13:18.60621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.247198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16233"}
{"level":"info","ts":"2026-05-01T14:13:18.606317Z","caller":"traceutil/trace.go:171","msg":"trace[1643609043] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4667; }","duration":"131.392121ms","start":"2026-05-01T14:13:18.474895Z","end":"2026-05-01T14:13:18.606287Z","steps":["trace[1643609043] 'agreement among raft nodes before linearized reading'  (duration: 130.856138ms)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:14:54.109639Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2868}
{"level":"info","ts":"2026-05-01T14:14:54.207535Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2868,"took":"96.627979ms","hash":1821970949,"current-db-size-bytes":54558720,"current-db-size":"55 MB","current-db-size-in-use-bytes":29474816,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-01T14:14:54.20761Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1821970949,"revision":2868,"compact-revision":-1}
{"level":"warn","ts":"2026-05-01T14:18:50.396407Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831519779846829,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-01T14:18:50.828298Z","caller":"traceutil/trace.go:171","msg":"trace[985829108] linearizableReadLoop","detail":"{readStateIndex:7332; appliedIndex:7332; }","duration":"932.496482ms","start":"2026-05-01T14:18:49.895775Z","end":"2026-05-01T14:18:50.828271Z","steps":["trace[985829108] 'read index received'  (duration: 932.485261ms)","trace[985829108] 'applied index is now lower than readState.Index'  (duration: 9.551µs)"],"step_count":2}
{"level":"info","ts":"2026-05-01T14:18:50.828297Z","caller":"traceutil/trace.go:171","msg":"trace[79668017] transaction","detail":"{read_only:false; response_revision:7070; number_of_response:1; }","duration":"960.390157ms","start":"2026-05-01T14:18:49.867886Z","end":"2026-05-01T14:18:50.828276Z","steps":["trace[79668017] 'process raft request'  (duration: 960.226212ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:18:50.828677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:49.867866Z","time spent":"960.729555ms","remote":"127.0.0.1:51364","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:7060 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-05-01T14:18:50.828531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"932.740457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-01T14:18:50.829Z","caller":"traceutil/trace.go:171","msg":"trace[1839862417] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7070; }","duration":"933.259218ms","start":"2026-05-01T14:18:49.895724Z","end":"2026-05-01T14:18:50.828983Z","steps":["trace[1839862417] 'agreement among raft nodes before linearized reading'  (duration: 932.701886ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:18:50.829046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:49.895703Z","time spent":"933.328069ms","remote":"127.0.0.1:51118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-01T14:18:51.329122Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5827831519779846832,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-01T14:18:51.787958Z","caller":"traceutil/trace.go:171","msg":"trace[947617912] transaction","detail":"{read_only:false; response_revision:7071; number_of_response:1; }","duration":"1.253295081s","start":"2026-05-01T14:18:50.534644Z","end":"2026-05-01T14:18:51.787939Z","steps":["trace[947617912] 'process raft request'  (duration: 1.24899345s)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:18:51.788086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:50.534622Z","time spent":"1.253392734s","remote":"127.0.0.1:51364","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:7067 > 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":"info","ts":"2026-05-01T14:18:51.788179Z","caller":"traceutil/trace.go:171","msg":"trace[1742322895] linearizableReadLoop","detail":"{readStateIndex:7335; appliedIndex:7332; }","duration":"959.645998ms","start":"2026-05-01T14:18:50.828512Z","end":"2026-05-01T14:18:51.788158Z","steps":["trace[1742322895] 'read index received'  (duration: 955.141622ms)","trace[1742322895] 'applied index is now lower than readState.Index'  (duration: 4.503586ms)"],"step_count":2}
{"level":"info","ts":"2026-05-01T14:18:51.788342Z","caller":"traceutil/trace.go:171","msg":"trace[1849551748] transaction","detail":"{read_only:false; response_revision:7072; number_of_response:1; }","duration":"471.329618ms","start":"2026-05-01T14:18:51.317001Z","end":"2026-05-01T14:18:51.788331Z","steps":["trace[1849551748] 'process raft request'  (duration: 470.907979ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:18:51.788376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.319141029s","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-01T14:18:51.788396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:51.316971Z","time spent":"471.397548ms","remote":"127.0.0.1:51364","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:7069 > 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-01T14:18:51.788406Z","caller":"traceutil/trace.go:171","msg":"trace[1120211516] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7073; }","duration":"1.319231441s","start":"2026-05-01T14:18:50.469167Z","end":"2026-05-01T14:18:51.788398Z","steps":["trace[1120211516] 'agreement among raft nodes before linearized reading'  (duration: 1.319102768s)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:18:51.788437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:50.469144Z","time spent":"1.319286562s","remote":"127.0.0.1:51364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-01T14:18:51.788414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.312152099s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-01T14:18:51.788487Z","caller":"traceutil/trace.go:171","msg":"trace[1127784289] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:7073; }","duration":"1.312255941s","start":"2026-05-01T14:18:50.476212Z","end":"2026-05-01T14:18:51.788468Z","steps":["trace[1127784289] 'agreement among raft nodes before linearized reading'  (duration: 1.312030547s)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:18:51.788538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:50.476199Z","time spent":"1.312329013s","remote":"127.0.0.1:51436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":95,"response size":30,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "}
{"level":"warn","ts":"2026-05-01T14:18:51.788603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.105155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-01T14:18:51.788628Z","caller":"traceutil/trace.go:171","msg":"trace[1779886406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7073; }","duration":"958.170257ms","start":"2026-05-01T14:18:50.830451Z","end":"2026-05-01T14:18:51.788621Z","steps":["trace[1779886406] 'agreement among raft nodes before linearized reading'  (duration: 958.133116ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:18:51.788645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:50.83043Z","time spent":"958.211168ms","remote":"127.0.0.1:51130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-01T14:18:51.78878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.582323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-01T14:18:51.788806Z","caller":"traceutil/trace.go:171","msg":"trace[2145645540] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:7073; }","duration":"471.651354ms","start":"2026-05-01T14:18:51.317147Z","end":"2026-05-01T14:18:51.788799Z","steps":["trace[2145645540] 'agreement among raft nodes before linearized reading'  (duration: 471.608184ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:18:51.788824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:51.317124Z","time spent":"471.695275ms","remote":"127.0.0.1:51342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":2,"response size":30,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "}
{"level":"warn","ts":"2026-05-01T14:18:51.788919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"972.887601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-05-01T14:18:51.788981Z","caller":"traceutil/trace.go:171","msg":"trace[580830682] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7073; }","duration":"973.005294ms","start":"2026-05-01T14:18:50.815962Z","end":"2026-05-01T14:18:51.788967Z","steps":["trace[580830682] 'agreement among raft nodes before linearized reading'  (duration: 972.83399ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:18:51.789001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.614268494s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-05-01T14:18:51.789023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:50.815932Z","time spent":"973.083536ms","remote":"127.0.0.1:51364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-05-01T14:18:51.789042Z","caller":"traceutil/trace.go:171","msg":"trace[196606901] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:7073; }","duration":"1.614350706s","start":"2026-05-01T14:18:50.174683Z","end":"2026-05-01T14:18:51.789034Z","steps":["trace[196606901] 'agreement among raft nodes before linearized reading'  (duration: 1.613887546s)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:18:51.789085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:50.174656Z","time spent":"1.614421837s","remote":"127.0.0.1:51584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":664,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"warn","ts":"2026-05-01T14:18:51.789089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.323565523s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-05-01T14:18:51.789123Z","caller":"traceutil/trace.go:171","msg":"trace[215188458] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7073; }","duration":"1.323622945s","start":"2026-05-01T14:18:50.46549Z","end":"2026-05-01T14:18:51.789113Z","steps":["trace[215188458] 'agreement among raft nodes before linearized reading'  (duration: 1.323515683s)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:18:51.789156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:50.46548Z","time spent":"1.323669576s","remote":"127.0.0.1:51364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-01T14:18:51.789197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.322163294s","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-05-01T14:18:51.789225Z","caller":"traceutil/trace.go:171","msg":"trace[1174928170] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7073; }","duration":"1.322212114s","start":"2026-05-01T14:18:50.467006Z","end":"2026-05-01T14:18:51.789219Z","steps":["trace[1174928170] 'agreement among raft nodes before linearized reading'  (duration: 1.322143913s)"],"step_count":1}
{"level":"info","ts":"2026-05-01T14:18:51.788763Z","caller":"traceutil/trace.go:171","msg":"trace[56477715] transaction","detail":"{read_only:false; response_revision:7073; number_of_response:1; }","duration":"470.49741ms","start":"2026-05-01T14:18:51.318243Z","end":"2026-05-01T14:18:51.78874Z","steps":["trace[56477715] 'process raft request'  (duration: 469.859337ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:18:51.789247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:50.466997Z","time spent":"1.322244995s","remote":"127.0.0.1:51364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-01T14:18:51.789265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.378830364s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"warn","ts":"2026-05-01T14:18:51.789293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:51.31821Z","time spent":"471.051532ms","remote":"127.0.0.1:51364","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:7027 > 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-05-01T14:18:51.789319Z","caller":"traceutil/trace.go:171","msg":"trace[1194440019] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7073; }","duration":"1.378909726s","start":"2026-05-01T14:18:50.410393Z","end":"2026-05-01T14:18:51.789303Z","steps":["trace[1194440019] 'agreement among raft nodes before linearized reading'  (duration: 1.378818104s)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:18:51.789369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:50.410377Z","time spent":"1.378982567s","remote":"127.0.0.1:51364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-05-01T14:18:51.789376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.384058476s","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-01T14:18:51.789394Z","caller":"traceutil/trace.go:171","msg":"trace[1401604000] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7073; }","duration":"1.384104017s","start":"2026-05-01T14:18:50.405285Z","end":"2026-05-01T14:18:51.789389Z","steps":["trace[1401604000] 'agreement among raft nodes before linearized reading'  (duration: 1.384045866s)"],"step_count":1}
{"level":"warn","ts":"2026-05-01T14:18:51.789425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:50.405263Z","time spent":"1.384156668s","remote":"127.0.0.1:51364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-05-01T14:19:54.114609Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5588}
{"level":"info","ts":"2026-05-01T14:19:54.183451Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5588,"took":"67.799047ms","hash":4242452906,"current-db-size-bytes":54558720,"current-db-size":"55 MB","current-db-size-in-use-bytes":18309120,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-05-01T14:19:54.18351Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4242452906,"revision":5588,"compact-revision":2868}