{"level":"warn","ts":"2026-09-22T14:46:43.140593Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-22T14:46:43.140739Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.156: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://162.253.55.156:2380","--initial-cluster=instance=https://162.253.55.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.156: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-09-22T14:46:43.140872Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-22T14:46:43.140899Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.156:2380"]}
{"level":"info","ts":"2026-09-22T14:46:43.140937Z","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-09-22T14:46:43.142108Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.156:2379"]}
{"level":"info","ts":"2026-09-22T14:46:43.142252Z","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://162.253.55.156:2380"],"listen-peer-urls":["https://162.253.55.156:2380"],"advertise-client-urls":["https://162.253.55.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.156: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-09-22T14:46:43.204642Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"61.986424ms"}
{"level":"info","ts":"2026-09-22T14:46:43.218391Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"40fb1eca294b6a5a","cluster-id":"17c6999805fcc0eb"}
{"level":"info","ts":"2026-09-22T14:46:43.218543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40fb1eca294b6a5a switched to configuration voters=()"}
{"level":"info","ts":"2026-09-22T14:46:43.218598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40fb1eca294b6a5a became follower at term 0"}
{"level":"info","ts":"2026-09-22T14:46:43.218653Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 40fb1eca294b6a5a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-09-22T14:46:43.219245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40fb1eca294b6a5a became follower at term 1"}
{"level":"info","ts":"2026-09-22T14:46:43.219307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40fb1eca294b6a5a switched to configuration voters=(4682370091206797914)"}
{"level":"warn","ts":"2026-09-22T14:46:43.238425Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-22T14:46:43.240467Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-22T14:46:43.242113Z","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-09-22T14:46:43.245207Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"40fb1eca294b6a5a","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-09-22T14:46:43.245402Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"40fb1eca294b6a5a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-09-22T14:46:43.245684Z","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-09-22T14:46:43.245962Z","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-09-22T14:46:43.246027Z","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-09-22T14:46:43.248208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40fb1eca294b6a5a switched to configuration voters=(4682370091206797914)"}
{"level":"info","ts":"2026-09-22T14:46:43.248576Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"17c6999805fcc0eb","local-member-id":"40fb1eca294b6a5a","added-peer-id":"40fb1eca294b6a5a","added-peer-peer-urls":["https://162.253.55.156:2380"]}
{"level":"info","ts":"2026-09-22T14:46:43.25141Z","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-09-22T14:46:43.251764Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"40fb1eca294b6a5a","initial-advertise-peer-urls":["https://162.253.55.156:2380"],"listen-peer-urls":["https://162.253.55.156:2380"],"advertise-client-urls":["https://162.253.55.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-09-22T14:46:43.25183Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-22T14:46:43.251939Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.156:2380"}
{"level":"info","ts":"2026-09-22T14:46:43.251964Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.156:2380"}
{"level":"info","ts":"2026-09-22T14:46:43.320439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40fb1eca294b6a5a is starting a new election at term 1"}
{"level":"info","ts":"2026-09-22T14:46:43.320555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40fb1eca294b6a5a became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-22T14:46:43.32058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40fb1eca294b6a5a received MsgPreVoteResp from 40fb1eca294b6a5a at term 1"}
{"level":"info","ts":"2026-09-22T14:46:43.320605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40fb1eca294b6a5a became candidate at term 2"}
{"level":"info","ts":"2026-09-22T14:46:43.320618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40fb1eca294b6a5a received MsgVoteResp from 40fb1eca294b6a5a at term 2"}
{"level":"info","ts":"2026-09-22T14:46:43.320635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40fb1eca294b6a5a became leader at term 2"}
{"level":"info","ts":"2026-09-22T14:46:43.320657Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 40fb1eca294b6a5a elected leader 40fb1eca294b6a5a at term 2"}
{"level":"info","ts":"2026-09-22T14:46:43.321787Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"40fb1eca294b6a5a","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.156:2379]}","request-path":"/0/members/40fb1eca294b6a5a/attributes","cluster-id":"17c6999805fcc0eb","publish-timeout":"7s"}
{"level":"info","ts":"2026-09-22T14:46:43.322035Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-22T14:46:43.322113Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-22T14:46:43.322315Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-22T14:46:43.323454Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"17c6999805fcc0eb","local-member-id":"40fb1eca294b6a5a","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-22T14:46:43.323586Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-22T14:46:43.323621Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-22T14:46:43.325973Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-09-22T14:46:43.326259Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.156:2379"}
{"level":"info","ts":"2026-09-22T14:46:43.326426Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-22T14:46:43.32646Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-22T14:47:22.111348Z","caller":"traceutil/trace.go:171","msg":"trace[124320685] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"120.641159ms","start":"2026-09-22T14:47:21.990684Z","end":"2026-09-22T14:47:22.111326Z","steps":["trace[124320685] 'process raft request'  (duration: 120.29455ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:47:29.260881Z","caller":"traceutil/trace.go:171","msg":"trace[1865877818] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"150.203723ms","start":"2026-09-22T14:47:29.110639Z","end":"2026-09-22T14:47:29.260843Z","steps":["trace[1865877818] 'read index received'  (duration: 148.96716ms)","trace[1865877818] 'applied index is now lower than readState.Index'  (duration: 1.234973ms)"],"step_count":2}
{"level":"info","ts":"2026-09-22T14:47:29.260963Z","caller":"traceutil/trace.go:171","msg":"trace[1003506107] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"336.186145ms","start":"2026-09-22T14:47:28.924728Z","end":"2026-09-22T14:47:29.260914Z","steps":["trace[1003506107] 'process raft request'  (duration: 335.296681ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T14:47:29.261069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.395758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-22T14:47:29.261157Z","caller":"traceutil/trace.go:171","msg":"trace[806544315] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:600; }","duration":"150.570612ms","start":"2026-09-22T14:47:29.110569Z","end":"2026-09-22T14:47:29.261139Z","steps":["trace[806544315] 'agreement among raft nodes before linearized reading'  (duration: 150.416918ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T14:47:29.262017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:47:28.924685Z","time spent":"336.39034ms","remote":"127.0.0.1:44678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:593 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036173 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-09-22T14:47:29.830192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.037603ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7663614503578834954 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:994 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-09-22T14:47:29.83044Z","caller":"traceutil/trace.go:171","msg":"trace[2000175807] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"150.351038ms","start":"2026-09-22T14:47:29.680064Z","end":"2026-09-22T14:47:29.830415Z","steps":["trace[2000175807] 'read index received'  (duration: 71.942µs)","trace[2000175807] 'applied index is now lower than readState.Index'  (duration: 150.277366ms)"],"step_count":2}
{"level":"info","ts":"2026-09-22T14:47:29.830483Z","caller":"traceutil/trace.go:171","msg":"trace[650886118] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"488.261699ms","start":"2026-09-22T14:47:29.342168Z","end":"2026-09-22T14:47:29.83043Z","steps":["trace[650886118] 'process raft request'  (duration: 330.514027ms)","trace[650886118] 'compare'  (duration: 156.698775ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-22T14:47:29.830679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:47:29.342137Z","time spent":"488.448074ms","remote":"127.0.0.1:44916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:994 >> failure:<>"}
{"level":"warn","ts":"2026-09-22T14:47:29.830912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.835651ms","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-09-22T14:47:29.831039Z","caller":"traceutil/trace.go:171","msg":"trace[581082862] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:601; }","duration":"151.050037ms","start":"2026-09-22T14:47:29.679975Z","end":"2026-09-22T14:47:29.831025Z","steps":["trace[581082862] 'agreement among raft nodes before linearized reading'  (duration: 150.548503ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:48:18.840301Z","caller":"traceutil/trace.go:171","msg":"trace[629410701] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"221.648028ms","start":"2026-09-22T14:48:18.618615Z","end":"2026-09-22T14:48:18.840263Z","steps":["trace[629410701] 'process raft request'  (duration: 221.396881ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:49:11.007871Z","caller":"traceutil/trace.go:171","msg":"trace[989331507] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"211.37923ms","start":"2026-09-22T14:49:10.796431Z","end":"2026-09-22T14:49:11.00781Z","steps":["trace[989331507] 'process raft request'  (duration: 152.087167ms)","trace[989331507] 'compare'  (duration: 58.628655ms)"],"step_count":2}
{"level":"info","ts":"2026-09-22T14:49:19.277553Z","caller":"traceutil/trace.go:171","msg":"trace[1478048002] linearizableReadLoop","detail":"{readStateIndex:2019; appliedIndex:2018; }","duration":"148.141051ms","start":"2026-09-22T14:49:19.129383Z","end":"2026-09-22T14:49:19.277524Z","steps":["trace[1478048002] 'read index received'  (duration: 102.706686ms)","trace[1478048002] 'applied index is now lower than readState.Index'  (duration: 45.432845ms)"],"step_count":2}
{"level":"info","ts":"2026-09-22T14:49:19.277583Z","caller":"traceutil/trace.go:171","msg":"trace[1990554355] transaction","detail":"{read_only:false; response_revision:1945; number_of_response:1; }","duration":"164.32039ms","start":"2026-09-22T14:49:19.113226Z","end":"2026-09-22T14:49:19.277546Z","steps":["trace[1990554355] 'process raft request'  (duration: 118.682359ms)","trace[1990554355] 'compare'  (duration: 45.383984ms)"],"step_count":2}
{"level":"info","ts":"2026-09-22T14:49:19.277938Z","caller":"traceutil/trace.go:171","msg":"trace[1073956236] transaction","detail":"{read_only:false; response_revision:1946; number_of_response:1; }","duration":"146.036135ms","start":"2026-09-22T14:49:19.13187Z","end":"2026-09-22T14:49:19.277906Z","steps":["trace[1073956236] 'process raft request'  (duration: 145.599863ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T14:49:19.277976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.570902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-22T14:49:19.278173Z","caller":"traceutil/trace.go:171","msg":"trace[778061895] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1946; }","duration":"148.790298ms","start":"2026-09-22T14:49:19.129337Z","end":"2026-09-22T14:49:19.278128Z","steps":["trace[778061895] 'agreement among raft nodes before linearized reading'  (duration: 148.327526ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T14:49:23.967708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.244968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11989"}
{"level":"info","ts":"2026-09-22T14:49:23.967779Z","caller":"traceutil/trace.go:171","msg":"trace[1387796999] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1975; }","duration":"115.386002ms","start":"2026-09-22T14:49:23.852378Z","end":"2026-09-22T14:49:23.967764Z","steps":["trace[1387796999] 'range keys from in-memory index tree'  (duration: 115.068163ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T14:49:23.968252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.12722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-h4wcg\" ","response":"range_response_count:1 size:5852"}
{"level":"info","ts":"2026-09-22T14:49:23.968376Z","caller":"traceutil/trace.go:171","msg":"trace[431892003] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-h4wcg; range_end:; response_count:1; response_revision:1975; }","duration":"373.352026ms","start":"2026-09-22T14:49:23.594995Z","end":"2026-09-22T14:49:23.968347Z","steps":["trace[431892003] 'range keys from in-memory index tree'  (duration: 372.778711ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T14:49:23.968434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:49:23.594972Z","time spent":"373.447638ms","remote":"127.0.0.1:44754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":5874,"request content":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-h4wcg\" "}
{"level":"warn","ts":"2026-09-22T14:49:23.968199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.544535ms","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-09-22T14:49:23.968535Z","caller":"traceutil/trace.go:171","msg":"trace[1909594251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1975; }","duration":"320.950545ms","start":"2026-09-22T14:49:23.647541Z","end":"2026-09-22T14:49:23.968492Z","steps":["trace[1909594251] 'range keys from in-memory index tree'  (duration: 320.268168ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T14:49:23.968659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:49:23.647502Z","time spent":"321.116079ms","remote":"127.0.0.1:44846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-09-22T14:49:50.188852Z","caller":"traceutil/trace.go:171","msg":"trace[92808037] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"122.237763ms","start":"2026-09-22T14:49:50.066571Z","end":"2026-09-22T14:49:50.188809Z","steps":["trace[92808037] 'process raft request'  (duration: 122.056569ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:50:01.380509Z","caller":"traceutil/trace.go:171","msg":"trace[795041903] transaction","detail":"{read_only:false; response_revision:2194; number_of_response:1; }","duration":"104.104853ms","start":"2026-09-22T14:50:01.276356Z","end":"2026-09-22T14:50:01.380461Z","steps":["trace[795041903] 'process raft request'  (duration: 103.830086ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:50:01.785305Z","caller":"traceutil/trace.go:171","msg":"trace[1815276927] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"281.217491ms","start":"2026-09-22T14:50:01.504053Z","end":"2026-09-22T14:50:01.78527Z","steps":["trace[1815276927] 'process raft request'  (duration: 281.012356ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T14:50:02.011265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.342544ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7663614503578838223 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2185 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-22T14:50:02.011586Z","caller":"traceutil/trace.go:171","msg":"trace[813653792] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"484.782114ms","start":"2026-09-22T14:50:01.526778Z","end":"2026-09-22T14:50:02.01156Z","steps":["trace[813653792] 'process raft request'  (duration: 341.04534ms)","trace[813653792] 'compare'  (duration: 142.997775ms)"],"step_count":2}
{"level":"info","ts":"2026-09-22T14:50:02.011625Z","caller":"traceutil/trace.go:171","msg":"trace[518246477] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"416.269836ms","start":"2026-09-22T14:50:01.595318Z","end":"2026-09-22T14:50:02.011588Z","steps":["trace[518246477] 'process raft request'  (duration: 416.071441ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:50:02.011686Z","caller":"traceutil/trace.go:171","msg":"trace[570810754] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"246.637195ms","start":"2026-09-22T14:50:01.764994Z","end":"2026-09-22T14:50:02.011631Z","steps":["trace[570810754] 'process raft request'  (duration: 246.528262ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T14:50:02.011726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.399129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-22T14:50:02.011784Z","caller":"traceutil/trace.go:171","msg":"trace[1148038249] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:2198; }","duration":"468.506562ms","start":"2026-09-22T14:50:01.543266Z","end":"2026-09-22T14:50:02.011773Z","steps":["trace[1148038249] 'agreement among raft nodes before linearized reading'  (duration: 468.370818ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T14:50:02.011809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:50:01.526739Z","time spent":"484.911888ms","remote":"127.0.0.1:44846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2185 > 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-09-22T14:50:02.011828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:50:01.595288Z","time spent":"416.43027ms","remote":"127.0.0.1:44846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2186 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-09-22T14:50:02.011831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:50:01.543242Z","time spent":"468.575634ms","remote":"127.0.0.1:44788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "}
{"level":"info","ts":"2026-09-22T14:50:02.011598Z","caller":"traceutil/trace.go:171","msg":"trace[762121333] linearizableReadLoop","detail":"{readStateIndex:2279; appliedIndex:2277; }","duration":"468.245805ms","start":"2026-09-22T14:50:01.543329Z","end":"2026-09-22T14:50:02.011575Z","steps":["trace[762121333] 'read index received'  (duration: 241.737514ms)","trace[762121333] 'applied index is now lower than readState.Index'  (duration: 226.507151ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-22T14:50:02.012188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.407533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-09-22T14:50:02.012298Z","caller":"traceutil/trace.go:171","msg":"trace[2036522881] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2198; }","duration":"389.556917ms","start":"2026-09-22T14:50:01.622718Z","end":"2026-09-22T14:50:02.012275Z","steps":["trace[2036522881] 'agreement among raft nodes before linearized reading'  (duration: 389.320371ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T14:50:02.012351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:50:01.622697Z","time spent":"389.641149ms","remote":"127.0.0.1:45888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-09-22T14:50:07.205298Z","caller":"traceutil/trace.go:171","msg":"trace[860164729] transaction","detail":"{read_only:false; response_revision:2222; number_of_response:1; }","duration":"120.454756ms","start":"2026-09-22T14:50:07.084819Z","end":"2026-09-22T14:50:07.205274Z","steps":["trace[860164729] 'process raft request'  (duration: 120.301432ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:50:58.491767Z","caller":"traceutil/trace.go:171","msg":"trace[1154265702] transaction","detail":"{read_only:false; response_revision:2669; number_of_response:1; }","duration":"249.735088ms","start":"2026-09-22T14:50:58.241997Z","end":"2026-09-22T14:50:58.491733Z","steps":["trace[1154265702] 'process raft request'  (duration: 249.546653ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:50:58.492607Z","caller":"traceutil/trace.go:171","msg":"trace[1320550264] transaction","detail":"{read_only:false; response_revision:2671; number_of_response:1; }","duration":"151.967949ms","start":"2026-09-22T14:50:58.340627Z","end":"2026-09-22T14:50:58.492595Z","steps":["trace[1320550264] 'process raft request'  (duration: 151.932198ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:50:58.492714Z","caller":"traceutil/trace.go:171","msg":"trace[1936246553] transaction","detail":"{read_only:false; response_revision:2670; number_of_response:1; }","duration":"240.647228ms","start":"2026-09-22T14:50:58.252058Z","end":"2026-09-22T14:50:58.492705Z","steps":["trace[1936246553] 'process raft request'  (duration: 240.434282ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:51:31.54809Z","caller":"traceutil/trace.go:171","msg":"trace[2117993455] linearizableReadLoop","detail":"{readStateIndex:2978; appliedIndex:2977; }","duration":"212.516805ms","start":"2026-09-22T14:51:31.335538Z","end":"2026-09-22T14:51:31.548055Z","steps":["trace[2117993455] 'read index received'  (duration: 212.123284ms)","trace[2117993455] 'applied index is now lower than readState.Index'  (duration: 392.25µs)"],"step_count":2}
{"level":"info","ts":"2026-09-22T14:51:31.548133Z","caller":"traceutil/trace.go:171","msg":"trace[4672977] transaction","detail":"{read_only:false; response_revision:2869; number_of_response:1; }","duration":"213.11234ms","start":"2026-09-22T14:51:31.334987Z","end":"2026-09-22T14:51:31.5481Z","steps":["trace[4672977] 'process raft request'  (duration: 212.820002ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T14:51:31.54854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.960766ms","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-09-22T14:51:31.548635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.593399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-22T14:51:31.548666Z","caller":"traceutil/trace.go:171","msg":"trace[422595076] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2869; }","duration":"213.10915ms","start":"2026-09-22T14:51:31.33553Z","end":"2026-09-22T14:51:31.548639Z","steps":["trace[422595076] 'agreement among raft nodes before linearized reading'  (duration: 212.674628ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:51:31.548708Z","caller":"traceutil/trace.go:171","msg":"trace[1254409575] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2869; }","duration":"157.755213ms","start":"2026-09-22T14:51:31.390939Z","end":"2026-09-22T14:51:31.548694Z","steps":["trace[1254409575] 'agreement among raft nodes before linearized reading'  (duration: 157.393694ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:51:36.777576Z","caller":"traceutil/trace.go:171","msg":"trace[1809655117] transaction","detail":"{read_only:false; response_revision:2897; number_of_response:1; }","duration":"126.820879ms","start":"2026-09-22T14:51:36.650716Z","end":"2026-09-22T14:51:36.777537Z","steps":["trace[1809655117] 'process raft request'  (duration: 126.640084ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:51:36.782654Z","caller":"traceutil/trace.go:171","msg":"trace[1932327513] transaction","detail":"{read_only:false; response_revision:2898; number_of_response:1; }","duration":"131.219244ms","start":"2026-09-22T14:51:36.65142Z","end":"2026-09-22T14:51:36.782639Z","steps":["trace[1932327513] 'process raft request'  (duration: 131.108371ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:51:36.782877Z","caller":"traceutil/trace.go:171","msg":"trace[1886003948] transaction","detail":"{read_only:false; response_revision:2899; number_of_response:1; }","duration":"130.778063ms","start":"2026-09-22T14:51:36.652038Z","end":"2026-09-22T14:51:36.782816Z","steps":["trace[1886003948] 'process raft request'  (duration: 130.559457ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:54:49.77083Z","caller":"traceutil/trace.go:171","msg":"trace[138920426] transaction","detail":"{read_only:false; response_revision:4114; number_of_response:1; }","duration":"206.113162ms","start":"2026-09-22T14:54:49.564684Z","end":"2026-09-22T14:54:49.770798Z","steps":["trace[138920426] 'process raft request'  (duration: 205.874205ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:54:49.931496Z","caller":"traceutil/trace.go:171","msg":"trace[828829305] linearizableReadLoop","detail":"{readStateIndex:4272; appliedIndex:4269; }","duration":"246.33811ms","start":"2026-09-22T14:54:49.685133Z","end":"2026-09-22T14:54:49.931471Z","steps":["trace[828829305] 'read index received'  (duration: 85.415727ms)","trace[828829305] 'applied index is now lower than readState.Index'  (duration: 160.921223ms)"],"step_count":2}
{"level":"info","ts":"2026-09-22T14:54:49.931863Z","caller":"traceutil/trace.go:171","msg":"trace[1144425378] transaction","detail":"{read_only:false; response_revision:4115; number_of_response:1; }","duration":"362.014952ms","start":"2026-09-22T14:54:49.569783Z","end":"2026-09-22T14:54:49.931798Z","steps":["trace[1144425378] 'process raft request'  (duration: 361.453057ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:54:49.931882Z","caller":"traceutil/trace.go:171","msg":"trace[1874396541] transaction","detail":"{read_only:false; response_revision:4116; number_of_response:1; }","duration":"362.076633ms","start":"2026-09-22T14:54:49.569765Z","end":"2026-09-22T14:54:49.931842Z","steps":["trace[1874396541] 'process raft request'  (duration: 361.652962ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T14:54:49.932145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:54:49.569735Z","time spent":"362.279699ms","remote":"127.0.0.1:44846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:4105 > 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-09-22T14:54:49.932155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:54:49.569767Z","time spent":"362.237318ms","remote":"127.0.0.1:44846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:4104 > 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-09-22T14:54:49.931904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.74177ms","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-09-22T14:54:49.932355Z","caller":"traceutil/trace.go:171","msg":"trace[909577991] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4116; }","duration":"247.205292ms","start":"2026-09-22T14:54:49.6851Z","end":"2026-09-22T14:54:49.932305Z","steps":["trace[909577991] 'agreement among raft nodes before linearized reading'  (duration: 246.581245ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:56:23.008606Z","caller":"traceutil/trace.go:171","msg":"trace[346582480] linearizableReadLoop","detail":"{readStateIndex:5387; appliedIndex:5386; }","duration":"108.38838ms","start":"2026-09-22T14:56:22.900185Z","end":"2026-09-22T14:56:23.008574Z","steps":["trace[346582480] 'read index received'  (duration: 88.931229ms)","trace[346582480] 'applied index is now lower than readState.Index'  (duration: 19.455961ms)"],"step_count":2}
{"level":"info","ts":"2026-09-22T14:56:23.008724Z","caller":"traceutil/trace.go:171","msg":"trace[1289417475] transaction","detail":"{read_only:false; response_revision:5189; number_of_response:1; }","duration":"108.566255ms","start":"2026-09-22T14:56:22.900042Z","end":"2026-09-22T14:56:23.008608Z","steps":["trace[1289417475] 'process raft request'  (duration: 89.041132ms)","trace[1289417475] 'compare'  (duration: 19.356059ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-22T14:56:23.009189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.951216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-xsg46-tls\" ","response":"range_response_count:1 size:2130"}
{"level":"info","ts":"2026-09-22T14:56:23.009373Z","caller":"traceutil/trace.go:171","msg":"trace[1616552545] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-xsg46-tls; range_end:; response_count:1; response_revision:5189; }","duration":"109.186402ms","start":"2026-09-22T14:56:22.90016Z","end":"2026-09-22T14:56:23.009346Z","steps":["trace[1616552545] 'agreement among raft nodes before linearized reading'  (duration: 108.470423ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T14:56:23.044749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.027358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:23 size:529257"}
{"level":"info","ts":"2026-09-22T14:56:23.044839Z","caller":"traceutil/trace.go:171","msg":"trace[2108695584] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:23; response_revision:5189; }","duration":"109.246784ms","start":"2026-09-22T14:56:22.935572Z","end":"2026-09-22T14:56:23.044819Z","steps":["trace[2108695584] 'agreement among raft nodes before linearized reading'  (duration: 108.683879ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T14:56:23.04526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.153606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"}
{"level":"info","ts":"2026-09-22T14:56:23.045461Z","caller":"traceutil/trace.go:171","msg":"trace[1676758989] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:5189; }","duration":"143.376501ms","start":"2026-09-22T14:56:22.902018Z","end":"2026-09-22T14:56:23.045394Z","steps":["trace[1676758989] 'agreement among raft nodes before linearized reading'  (duration: 142.147898ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:56:24.428823Z","caller":"traceutil/trace.go:171","msg":"trace[1345101905] transaction","detail":"{read_only:false; response_revision:5218; number_of_response:1; }","duration":"100.290368ms","start":"2026-09-22T14:56:24.328505Z","end":"2026-09-22T14:56:24.428795Z","steps":["trace[1345101905] 'process raft request'  (duration: 100.086782ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:56:24.43022Z","caller":"traceutil/trace.go:171","msg":"trace[123030467] transaction","detail":"{read_only:false; response_revision:5219; number_of_response:1; }","duration":"100.105293ms","start":"2026-09-22T14:56:24.330078Z","end":"2026-09-22T14:56:24.430184Z","steps":["trace[123030467] 'process raft request'  (duration: 99.942039ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:56:43.902571Z","caller":"traceutil/trace.go:171","msg":"trace[2138635221] transaction","detail":"{read_only:false; response_revision:5623; number_of_response:1; }","duration":"393.47957ms","start":"2026-09-22T14:56:43.509057Z","end":"2026-09-22T14:56:43.902536Z","steps":["trace[2138635221] 'process raft request'  (duration: 393.283734ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T14:56:43.902822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:56:43.509026Z","time spent":"393.652524ms","remote":"127.0.0.1:44846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5566 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-09-22T14:56:43.914055Z","caller":"traceutil/trace.go:171","msg":"trace[1784609147] transaction","detail":"{read_only:false; response_revision:5624; number_of_response:1; }","duration":"368.214015ms","start":"2026-09-22T14:56:43.545823Z","end":"2026-09-22T14:56:43.914037Z","steps":["trace[1784609147] 'process raft request'  (duration: 368.070791ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:56:43.914169Z","caller":"traceutil/trace.go:171","msg":"trace[131307006] linearizableReadLoop","detail":"{readStateIndex:5838; appliedIndex:5836; }","duration":"313.26587ms","start":"2026-09-22T14:56:43.600888Z","end":"2026-09-22T14:56:43.914154Z","steps":["trace[131307006] 'read index received'  (duration: 301.504881ms)","trace[131307006] 'applied index is now lower than readState.Index'  (duration: 11.760119ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-22T14:56:43.914254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:56:43.545786Z","time spent":"368.378209ms","remote":"127.0.0.1:44846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:5567 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-09-22T14:56:43.914359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.475275ms","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-09-22T14:56:43.9144Z","caller":"traceutil/trace.go:171","msg":"trace[160905077] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5625; }","duration":"313.517976ms","start":"2026-09-22T14:56:43.60087Z","end":"2026-09-22T14:56:43.914388Z","steps":["trace[160905077] 'agreement among raft nodes before linearized reading'  (duration: 313.366402ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T14:56:43.914428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:56:43.60079Z","time spent":"313.630929ms","remote":"127.0.0.1:44846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-09-22T14:56:43.914481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.268046ms","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-09-22T14:56:43.914579Z","caller":"traceutil/trace.go:171","msg":"trace[2131217227] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5625; }","duration":"268.40197ms","start":"2026-09-22T14:56:43.646148Z","end":"2026-09-22T14:56:43.91455Z","steps":["trace[2131217227] 'agreement among raft nodes before linearized reading'  (duration: 268.134103ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T14:56:43.914465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.049213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-22T14:56:43.914743Z","caller":"traceutil/trace.go:171","msg":"trace[929681091] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:5625; }","duration":"124.418242ms","start":"2026-09-22T14:56:43.790303Z","end":"2026-09-22T14:56:43.914721Z","steps":["trace[929681091] 'agreement among raft nodes before linearized reading'  (duration: 124.029962ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:56:43.914915Z","caller":"traceutil/trace.go:171","msg":"trace[919729739] transaction","detail":"{read_only:false; response_revision:5625; number_of_response:1; }","duration":"211.535004ms","start":"2026-09-22T14:56:43.702685Z","end":"2026-09-22T14:56:43.91422Z","steps":["trace[919729739] 'process raft request'  (duration: 211.310358ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:56:43.925474Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2938}
{"level":"info","ts":"2026-09-22T14:56:44.057186Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2938,"took":"129.395373ms","hash":2770286022,"current-db-size-bytes":56295424,"current-db-size":"56 MB","current-db-size-in-use-bytes":31604736,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-09-22T14:56:44.057268Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2770286022,"revision":2938,"compact-revision":-1}
{"level":"info","ts":"2026-09-22T14:57:46.625417Z","caller":"traceutil/trace.go:171","msg":"trace[618460482] linearizableReadLoop","detail":"{readStateIndex:6536; appliedIndex:6535; }","duration":"105.044831ms","start":"2026-09-22T14:57:46.52034Z","end":"2026-09-22T14:57:46.625385Z","steps":["trace[618460482] 'read index received'  (duration: 66.71731ms)","trace[618460482] 'applied index is now lower than readState.Index'  (duration: 38.326621ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-22T14:57:46.625758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.367589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"}
{"level":"info","ts":"2026-09-22T14:57:46.625801Z","caller":"traceutil/trace.go:171","msg":"trace[1101982457] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:6304; }","duration":"105.526824ms","start":"2026-09-22T14:57:46.520262Z","end":"2026-09-22T14:57:46.625789Z","steps":["trace[1101982457] 'agreement among raft nodes before linearized reading'  (duration: 105.258557ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T14:57:46.625954Z","caller":"traceutil/trace.go:171","msg":"trace[1108503308] transaction","detail":"{read_only:false; response_revision:6304; number_of_response:1; }","duration":"106.160141ms","start":"2026-09-22T14:57:46.519739Z","end":"2026-09-22T14:57:46.625899Z","steps":["trace[1108503308] 'process raft request'  (duration: 67.417009ms)","trace[1108503308] 'compare'  (duration: 38.106155ms)"],"step_count":2}
{"level":"info","ts":"2026-09-22T15:01:43.932806Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5625}
{"level":"info","ts":"2026-09-22T15:01:44.02511Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5625,"took":"89.899826ms","hash":1989508435,"current-db-size-bytes":56295424,"current-db-size":"56 MB","current-db-size-in-use-bytes":26599424,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-09-22T15:01:44.025263Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1989508435,"revision":5625,"compact-revision":2938}
{"level":"info","ts":"2026-09-22T15:03:01.77964Z","caller":"traceutil/trace.go:171","msg":"trace[455742394] linearizableReadLoop","detail":"{readStateIndex:8941; appliedIndex:8940; }","duration":"152.868836ms","start":"2026-09-22T15:03:01.626747Z","end":"2026-09-22T15:03:01.779616Z","steps":["trace[455742394] 'read index received'  (duration: 152.661851ms)","trace[455742394] 'applied index is now lower than readState.Index'  (duration: 205.815µs)"],"step_count":2}
{"level":"info","ts":"2026-09-22T15:03:01.779717Z","caller":"traceutil/trace.go:171","msg":"trace[1371517020] transaction","detail":"{read_only:false; response_revision:8635; number_of_response:1; }","duration":"243.588526ms","start":"2026-09-22T15:03:01.536075Z","end":"2026-09-22T15:03:01.779664Z","steps":["trace[1371517020] 'process raft request'  (duration: 243.391701ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T15:03:01.779831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.071051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-22T15:03:01.77987Z","caller":"traceutil/trace.go:171","msg":"trace[219952025] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8635; }","duration":"153.182185ms","start":"2026-09-22T15:03:01.626676Z","end":"2026-09-22T15:03:01.779858Z","steps":["trace[219952025] 'agreement among raft nodes before linearized reading'  (duration: 153.099853ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T15:03:01.77997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.074867ms","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-09-22T15:03:01.780021Z","caller":"traceutil/trace.go:171","msg":"trace[100595879] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8635; }","duration":"109.1842ms","start":"2026-09-22T15:03:01.670824Z","end":"2026-09-22T15:03:01.780008Z","steps":["trace[100595879] 'agreement among raft nodes before linearized reading'  (duration: 109.028536ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T15:03:14.179309Z","caller":"traceutil/trace.go:171","msg":"trace[535080848] linearizableReadLoop","detail":"{readStateIndex:9008; appliedIndex:9007; }","duration":"160.813372ms","start":"2026-09-22T15:03:14.018462Z","end":"2026-09-22T15:03:14.179275Z","steps":["trace[535080848] 'read index received'  (duration: 115.237407ms)","trace[535080848] 'applied index is now lower than readState.Index'  (duration: 45.573805ms)"],"step_count":2}
{"level":"info","ts":"2026-09-22T15:03:14.179543Z","caller":"traceutil/trace.go:171","msg":"trace[1445758283] transaction","detail":"{read_only:false; response_revision:8698; number_of_response:1; }","duration":"261.033008ms","start":"2026-09-22T15:03:13.91847Z","end":"2026-09-22T15:03:14.179503Z","steps":["trace[1445758283] 'process raft request'  (duration: 215.135505ms)","trace[1445758283] 'compare'  (duration: 45.37862ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-22T15:03:14.179712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.202432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-09-22T15:03:14.179793Z","caller":"traceutil/trace.go:171","msg":"trace[658546791] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8698; }","duration":"161.378526ms","start":"2026-09-22T15:03:14.018396Z","end":"2026-09-22T15:03:14.179775Z","steps":["trace[658546791] 'agreement among raft nodes before linearized reading'  (duration: 161.099179ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T15:03:14.200625Z","caller":"traceutil/trace.go:171","msg":"trace[755476336] transaction","detail":"{read_only:false; response_revision:8699; number_of_response:1; }","duration":"115.352609ms","start":"2026-09-22T15:03:14.085247Z","end":"2026-09-22T15:03:14.2006Z","steps":["trace[755476336] 'process raft request'  (duration: 115.187795ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T15:03:14.200841Z","caller":"traceutil/trace.go:171","msg":"trace[440038169] transaction","detail":"{read_only:false; response_revision:8700; number_of_response:1; }","duration":"110.793331ms","start":"2026-09-22T15:03:14.090033Z","end":"2026-09-22T15:03:14.200826Z","steps":["trace[440038169] 'process raft request'  (duration: 110.529494ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T15:03:14.200926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.979562ms","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-09-22T15:03:14.20099Z","caller":"traceutil/trace.go:171","msg":"trace[2006005397] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8700; }","duration":"167.090855ms","start":"2026-09-22T15:03:14.033886Z","end":"2026-09-22T15:03:14.200976Z","steps":["trace[2006005397] 'agreement among raft nodes before linearized reading'  (duration: 166.936781ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T15:03:14.200992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.577144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-09-22T15:03:14.201088Z","caller":"traceutil/trace.go:171","msg":"trace[1996288289] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8700; }","duration":"173.683896ms","start":"2026-09-22T15:03:14.027389Z","end":"2026-09-22T15:03:14.201073Z","steps":["trace[1996288289] 'agreement among raft nodes before linearized reading'  (duration: 173.381838ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T15:03:26.280807Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000237d.wal"}