{"level":"warn","ts":"2026-05-08T18:18:13.675285Z","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-08T18:18:13.675375Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.176:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.176:2380","--initial-cluster=instance=https://199.19.213.176:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.176:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.176: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-08T18:18:13.675441Z","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-08T18:18:13.675454Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.176:2380"]} {"level":"info","ts":"2026-05-08T18:18:13.675471Z","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-08T18:18:13.676135Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.176:2379"]} {"level":"info","ts":"2026-05-08T18:18:13.676224Z","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.19.213.176:2380"],"listen-peer-urls":["https://199.19.213.176:2380"],"advertise-client-urls":["https://199.19.213.176:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.176:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.176: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-08T18:18:13.681175Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.666439ms"} {"level":"info","ts":"2026-05-08T18:18:13.690086Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6e120e57916b9bd4","cluster-id":"e644555f29703ff6"} {"level":"info","ts":"2026-05-08T18:18:13.690158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 switched to configuration voters=()"} {"level":"info","ts":"2026-05-08T18:18:13.690176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 became follower at term 0"} {"level":"info","ts":"2026-05-08T18:18:13.690188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6e120e57916b9bd4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-08T18:18:13.690198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 became follower at term 1"} {"level":"info","ts":"2026-05-08T18:18:13.690235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 switched to configuration voters=(7931417663017556948)"} {"level":"warn","ts":"2026-05-08T18:18:13.696792Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-08T18:18:13.698014Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-08T18:18:13.702048Z","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-08T18:18:13.704664Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6e120e57916b9bd4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-08T18:18:13.704836Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6e120e57916b9bd4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-08T18:18:13.704911Z","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-08T18:18:13.704956Z","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-08T18:18:13.704966Z","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-08T18:18:13.705882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 switched to configuration voters=(7931417663017556948)"} {"level":"info","ts":"2026-05-08T18:18:13.713262Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e644555f29703ff6","local-member-id":"6e120e57916b9bd4","added-peer-id":"6e120e57916b9bd4","added-peer-peer-urls":["https://199.19.213.176:2380"]} {"level":"info","ts":"2026-05-08T18:18:13.714381Z","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-08T18:18:13.714546Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6e120e57916b9bd4","initial-advertise-peer-urls":["https://199.19.213.176:2380"],"listen-peer-urls":["https://199.19.213.176:2380"],"advertise-client-urls":["https://199.19.213.176:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.176:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-08T18:18:13.714553Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.176:2380"} {"level":"info","ts":"2026-05-08T18:18:13.714568Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-08T18:18:13.714576Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.176:2380"} {"level":"info","ts":"2026-05-08T18:18:14.290448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 is starting a new election at term 1"} {"level":"info","ts":"2026-05-08T18:18:14.290548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-08T18:18:14.2906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 received MsgPreVoteResp from 6e120e57916b9bd4 at term 1"} {"level":"info","ts":"2026-05-08T18:18:14.290631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 became candidate at term 2"} {"level":"info","ts":"2026-05-08T18:18:14.29066Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 received MsgVoteResp from 6e120e57916b9bd4 at term 2"} {"level":"info","ts":"2026-05-08T18:18:14.290687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e120e57916b9bd4 became leader at term 2"} {"level":"info","ts":"2026-05-08T18:18:14.290711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6e120e57916b9bd4 elected leader 6e120e57916b9bd4 at term 2"} {"level":"info","ts":"2026-05-08T18:18:14.446836Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T18:18:14.451589Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6e120e57916b9bd4","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.176:2379]}","request-path":"/0/members/6e120e57916b9bd4/attributes","cluster-id":"e644555f29703ff6","publish-timeout":"7s"} {"level":"info","ts":"2026-05-08T18:18:14.451777Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T18:18:14.451888Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T18:18:14.452054Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-08T18:18:14.452081Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-08T18:18:14.454634Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-08T18:18:14.45478Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e644555f29703ff6","local-member-id":"6e120e57916b9bd4","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T18:18:14.455595Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T18:18:14.455768Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T18:18:14.456182Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.176:2379"} {"level":"info","ts":"2026-05-08T18:18:51.325217Z","caller":"traceutil/trace.go:171","msg":"trace[1841620125] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"133.592977ms","start":"2026-05-08T18:18:51.1916Z","end":"2026-05-08T18:18:51.325193Z","steps":["trace[1841620125] 'process raft request' (duration: 133.367327ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:18:51.808079Z","caller":"traceutil/trace.go:171","msg":"trace[927025025] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"333.313851ms","start":"2026-05-08T18:18:51.474736Z","end":"2026-05-08T18:18:51.80805Z","steps":["trace[927025025] 'process raft request' (duration: 332.7445ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:18:51.808869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:18:51.474715Z","time spent":"333.440341ms","remote":"127.0.0.1:33680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T18:19:07.050096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.646444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:19:07.050242Z","caller":"traceutil/trace.go:171","msg":"trace[566163609] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:784; }","duration":"233.884205ms","start":"2026-05-08T18:19:06.816333Z","end":"2026-05-08T18:19:07.050217Z","steps":["trace[566163609] 'range keys from in-memory index tree' (duration: 233.529104ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:19:07.050301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.023704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-08T18:19:07.050401Z","caller":"traceutil/trace.go:171","msg":"trace[477718717] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:784; }","duration":"136.184204ms","start":"2026-05-08T18:19:06.914195Z","end":"2026-05-08T18:19:07.050379Z","steps":["trace[477718717] 'range keys from in-memory index tree' (duration: 135.576393ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:19:36.576258Z","caller":"traceutil/trace.go:171","msg":"trace[916592582] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"124.3516ms","start":"2026-05-08T18:19:36.45188Z","end":"2026-05-08T18:19:36.576232Z","steps":["trace[916592582] 'process raft request' (duration: 124.17755ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:20:15.450874Z","caller":"traceutil/trace.go:171","msg":"trace[1855913153] transaction","detail":"{read_only:false; response_revision:1723; number_of_response:1; }","duration":"144.343892ms","start":"2026-05-08T18:20:15.306506Z","end":"2026-05-08T18:20:15.450849Z","steps":["trace[1855913153] 'process raft request' (duration: 72.110586ms)","trace[1855913153] 'compare' (duration: 72.134436ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:20:20.291094Z","caller":"traceutil/trace.go:171","msg":"trace[1829720953] linearizableReadLoop","detail":"{readStateIndex:1879; appliedIndex:1878; }","duration":"130.25418ms","start":"2026-05-08T18:20:20.160816Z","end":"2026-05-08T18:20:20.29107Z","steps":["trace[1829720953] 'read index received' (duration: 130.1002ms)","trace[1829720953] 'applied index is now lower than readState.Index' (duration: 152.9µs)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:20:20.291412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.546601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"} {"level":"info","ts":"2026-05-08T18:20:20.291466Z","caller":"traceutil/trace.go:171","msg":"trace[690095961] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1825; }","duration":"130.673572ms","start":"2026-05-08T18:20:20.160779Z","end":"2026-05-08T18:20:20.291453Z","steps":["trace[690095961] 'agreement among raft nodes before linearized reading' (duration: 130.451832ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:20:20.291556Z","caller":"traceutil/trace.go:171","msg":"trace[1758734198] transaction","detail":"{read_only:false; response_revision:1825; number_of_response:1; }","duration":"229.531654ms","start":"2026-05-08T18:20:20.061961Z","end":"2026-05-08T18:20:20.291492Z","steps":["trace[1758734198] 'process raft request' (duration: 228.930133ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:20:20.708397Z","caller":"traceutil/trace.go:171","msg":"trace[1745943433] linearizableReadLoop","detail":"{readStateIndex:1880; appliedIndex:1879; }","duration":"178.530174ms","start":"2026-05-08T18:20:20.529842Z","end":"2026-05-08T18:20:20.708372Z","steps":["trace[1745943433] 'read index received' (duration: 178.260843ms)","trace[1745943433] 'applied index is now lower than readState.Index' (duration: 267.951µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:20:20.708538Z","caller":"traceutil/trace.go:171","msg":"trace[1712617094] transaction","detail":"{read_only:false; response_revision:1826; number_of_response:1; }","duration":"243.770515ms","start":"2026-05-08T18:20:20.464722Z","end":"2026-05-08T18:20:20.708493Z","steps":["trace[1712617094] 'process raft request' (duration: 243.459163ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:20:20.708701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.827365ms","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-08T18:20:20.708745Z","caller":"traceutil/trace.go:171","msg":"trace[326334554] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1826; }","duration":"178.940265ms","start":"2026-05-08T18:20:20.529794Z","end":"2026-05-08T18:20:20.708734Z","steps":["trace[326334554] 'agreement among raft nodes before linearized reading' (duration: 178.768525ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:20:20.709265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.655642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:9033"} {"level":"info","ts":"2026-05-08T18:20:20.709343Z","caller":"traceutil/trace.go:171","msg":"trace[1837907205] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1826; }","duration":"116.780452ms","start":"2026-05-08T18:20:20.592541Z","end":"2026-05-08T18:20:20.709321Z","steps":["trace[1837907205] 'agreement among raft nodes before linearized reading' (duration: 116.353991ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:20:20.932844Z","caller":"traceutil/trace.go:171","msg":"trace[850198599] linearizableReadLoop","detail":"{readStateIndex:1882; appliedIndex:1881; }","duration":"184.526007ms","start":"2026-05-08T18:20:20.748298Z","end":"2026-05-08T18:20:20.932824Z","steps":["trace[850198599] 'read index received' (duration: 1.087272ms)","trace[850198599] 'applied index is now lower than readState.Index' (duration: 183.437745ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:20:20.932886Z","caller":"traceutil/trace.go:171","msg":"trace[1604823301] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"212.652337ms","start":"2026-05-08T18:20:20.720206Z","end":"2026-05-08T18:20:20.932858Z","steps":["trace[1604823301] 'process raft request' (duration: 212.482637ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:20:20.933077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.761108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-efc608fd-079b-4423-acbc-a265b2ddbaaa\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-08T18:20:20.933145Z","caller":"traceutil/trace.go:171","msg":"trace[863824050] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-efc608fd-079b-4423-acbc-a265b2ddbaaa; range_end:; response_count:1; response_revision:1828; }","duration":"184.843038ms","start":"2026-05-08T18:20:20.748291Z","end":"2026-05-08T18:20:20.933134Z","steps":["trace[863824050] 'agreement among raft nodes before linearized reading' (duration: 184.651597ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:20:20.933383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.922119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-08T18:20:20.933491Z","caller":"traceutil/trace.go:171","msg":"trace[1352604413] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1828; }","duration":"167.064369ms","start":"2026-05-08T18:20:20.766399Z","end":"2026-05-08T18:20:20.933464Z","steps":["trace[1352604413] 'agreement among raft nodes before linearized reading' (duration: 166.774489ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:20:26.008815Z","caller":"traceutil/trace.go:171","msg":"trace[759451665] transaction","detail":"{read_only:false; response_revision:1899; number_of_response:1; }","duration":"109.334685ms","start":"2026-05-08T18:20:25.899455Z","end":"2026-05-08T18:20:26.00879Z","steps":["trace[759451665] 'process raft request' (duration: 109.138205ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:20:28.435416Z","caller":"traceutil/trace.go:171","msg":"trace[1662607771] transaction","detail":"{read_only:false; response_revision:1921; number_of_response:1; }","duration":"107.047409ms","start":"2026-05-08T18:20:28.328352Z","end":"2026-05-08T18:20:28.4354Z","steps":["trace[1662607771] 'process raft request' (duration: 106.544248ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:20:52.312517Z","caller":"traceutil/trace.go:171","msg":"trace[109790399] transaction","detail":"{read_only:false; response_revision:2093; number_of_response:1; }","duration":"259.752623ms","start":"2026-05-08T18:20:52.052727Z","end":"2026-05-08T18:20:52.31248Z","steps":["trace[109790399] 'process raft request' (duration: 259.514642ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:20:52.523692Z","caller":"traceutil/trace.go:171","msg":"trace[317603521] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"122.716652ms","start":"2026-05-08T18:20:52.400945Z","end":"2026-05-08T18:20:52.523661Z","steps":["trace[317603521] 'process raft request' (duration: 99.09626ms)","trace[317603521] 'compare' (duration: 23.495971ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:21:45.417643Z","caller":"traceutil/trace.go:171","msg":"trace[1799694899] linearizableReadLoop","detail":"{readStateIndex:2649; appliedIndex:2647; }","duration":"170.409951ms","start":"2026-05-08T18:21:45.247203Z","end":"2026-05-08T18:21:45.417613Z","steps":["trace[1799694899] 'read index received' (duration: 166.233392ms)","trace[1799694899] 'applied index is now lower than readState.Index' (duration: 4.175139ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:21:45.417801Z","caller":"traceutil/trace.go:171","msg":"trace[514291986] transaction","detail":"{read_only:false; response_revision:2556; number_of_response:1; }","duration":"195.428025ms","start":"2026-05-08T18:21:45.222357Z","end":"2026-05-08T18:21:45.417785Z","steps":["trace[514291986] 'process raft request' (duration: 191.088915ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:21:45.417932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.707062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1296"} {"level":"info","ts":"2026-05-08T18:21:45.418001Z","caller":"traceutil/trace.go:171","msg":"trace[41032716] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2557; }","duration":"170.805613ms","start":"2026-05-08T18:21:45.247173Z","end":"2026-05-08T18:21:45.417979Z","steps":["trace[41032716] 'agreement among raft nodes before linearized reading' (duration: 170.620123ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:21:45.418131Z","caller":"traceutil/trace.go:171","msg":"trace[1564193248] transaction","detail":"{read_only:false; response_revision:2557; number_of_response:1; }","duration":"193.49651ms","start":"2026-05-08T18:21:45.224597Z","end":"2026-05-08T18:21:45.418094Z","steps":["trace[1564193248] 'process raft request' (duration: 192.940369ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:22:07.568771Z","caller":"traceutil/trace.go:171","msg":"trace[1655306812] transaction","detail":"{read_only:false; response_revision:2712; number_of_response:1; }","duration":"114.443063ms","start":"2026-05-08T18:22:07.454285Z","end":"2026-05-08T18:22:07.568728Z","steps":["trace[1655306812] 'process raft request' (duration: 114.229852ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:22:13.279471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.418401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-05-08T18:22:13.279582Z","caller":"traceutil/trace.go:171","msg":"trace[1785369012] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2748; }","duration":"170.616172ms","start":"2026-05-08T18:22:13.108945Z","end":"2026-05-08T18:22:13.279561Z","steps":["trace[1785369012] 'range keys from in-memory index tree' (duration: 170.182041ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:22:13.395869Z","caller":"traceutil/trace.go:171","msg":"trace[900031499] linearizableReadLoop","detail":"{readStateIndex:2853; appliedIndex:2852; }","duration":"110.045593ms","start":"2026-05-08T18:22:13.285806Z","end":"2026-05-08T18:22:13.395851Z","steps":["trace[900031499] 'read index received' (duration: 109.941692ms)","trace[900031499] 'applied index is now lower than readState.Index' (duration: 103.171µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:22:13.396055Z","caller":"traceutil/trace.go:171","msg":"trace[324852563] transaction","detail":"{read_only:false; response_revision:2749; number_of_response:1; }","duration":"110.348154ms","start":"2026-05-08T18:22:13.285698Z","end":"2026-05-08T18:22:13.396046Z","steps":["trace[324852563] 'process raft request' (duration: 110.055063ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:22:13.396266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.457923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1247"} {"level":"info","ts":"2026-05-08T18:22:13.396289Z","caller":"traceutil/trace.go:171","msg":"trace[1886020980] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:2749; }","duration":"110.518433ms","start":"2026-05-08T18:22:13.285763Z","end":"2026-05-08T18:22:13.396282Z","steps":["trace[1886020980] 'agreement among raft nodes before linearized reading' (duration: 110.424753ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:22:13.396406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.883233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:551"} {"level":"info","ts":"2026-05-08T18:22:13.396427Z","caller":"traceutil/trace.go:171","msg":"trace[211924116] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2749; }","duration":"109.920793ms","start":"2026-05-08T18:22:13.286499Z","end":"2026-05-08T18:22:13.39642Z","steps":["trace[211924116] 'agreement among raft nodes before linearized reading' (duration: 109.870013ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:22:13.584364Z","caller":"traceutil/trace.go:171","msg":"trace[980956737] linearizableReadLoop","detail":"{readStateIndex:2855; appliedIndex:2854; }","duration":"101.816666ms","start":"2026-05-08T18:22:13.482521Z","end":"2026-05-08T18:22:13.584338Z","steps":["trace[980956737] 'read index received' (duration: 51.835761ms)","trace[980956737] 'applied index is now lower than readState.Index' (duration: 49.979485ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:22:13.58451Z","caller":"traceutil/trace.go:171","msg":"trace[303934725] transaction","detail":"{read_only:false; response_revision:2751; number_of_response:1; }","duration":"152.434354ms","start":"2026-05-08T18:22:13.432062Z","end":"2026-05-08T18:22:13.584496Z","steps":["trace[303934725] 'process raft request' (duration: 102.356628ms)","trace[303934725] 'compare' (duration: 49.797165ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:22:13.584834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.292618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:22:13.584907Z","caller":"traceutil/trace.go:171","msg":"trace[1544095087] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2751; }","duration":"102.449798ms","start":"2026-05-08T18:22:13.482439Z","end":"2026-05-08T18:22:13.584888Z","steps":["trace[1544095087] 'agreement among raft nodes before linearized reading' (duration: 102.335778ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:24:29.848919Z","caller":"traceutil/trace.go:171","msg":"trace[459212719] linearizableReadLoop","detail":"{readStateIndex:4475; appliedIndex:4474; }","duration":"131.439182ms","start":"2026-05-08T18:24:29.717448Z","end":"2026-05-08T18:24:29.848887Z","steps":["trace[459212719] 'read index received' (duration: 116.84734ms)","trace[459212719] 'applied index is now lower than readState.Index' (duration: 14.590592ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:24:29.849233Z","caller":"traceutil/trace.go:171","msg":"trace[133323787] transaction","detail":"{read_only:false; response_revision:4291; number_of_response:1; }","duration":"135.248432ms","start":"2026-05-08T18:24:29.713969Z","end":"2026-05-08T18:24:29.849217Z","steps":["trace[133323787] 'process raft request' (duration: 120.411586ms)","trace[133323787] 'compare' (duration: 14.049555ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:24:29.849576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.110378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3465"} {"level":"info","ts":"2026-05-08T18:24:29.849629Z","caller":"traceutil/trace.go:171","msg":"trace[932031799] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4291; }","duration":"132.195283ms","start":"2026-05-08T18:24:29.71742Z","end":"2026-05-08T18:24:29.849615Z","steps":["trace[932031799] 'agreement among raft nodes before linearized reading' (duration: 132.024304ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:24:29.849843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.838285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:24:29.849935Z","caller":"traceutil/trace.go:171","msg":"trace[728799224] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:4291; }","duration":"102.024465ms","start":"2026-05-08T18:24:29.747869Z","end":"2026-05-08T18:24:29.849894Z","steps":["trace[728799224] 'agreement among raft nodes before linearized reading' (duration: 101.909269ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:24:37.154417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.297259ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T18:24:37.154586Z","caller":"traceutil/trace.go:171","msg":"trace[406721750] transaction","detail":"{read_only:false; response_revision:4475; number_of_response:1; }","duration":"250.022363ms","start":"2026-05-08T18:24:36.904552Z","end":"2026-05-08T18:24:37.154575Z","steps":["trace[406721750] 'process raft request' (duration: 249.981851ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:24:37.154651Z","caller":"traceutil/trace.go:171","msg":"trace[1788603625] linearizableReadLoop","detail":"{readStateIndex:4662; appliedIndex:4661; }","duration":"366.960975ms","start":"2026-05-08T18:24:36.787668Z","end":"2026-05-08T18:24:37.154629Z","steps":["trace[1788603625] 'read index received' (duration: 72.268327ms)","trace[1788603625] 'applied index is now lower than readState.Index' (duration: 294.690258ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:24:37.154656Z","caller":"traceutil/trace.go:171","msg":"trace[342635960] transaction","detail":"{read_only:false; response_revision:4474; number_of_response:1; }","duration":"377.018327ms","start":"2026-05-08T18:24:36.777609Z","end":"2026-05-08T18:24:37.154627Z","steps":["trace[342635960] 'process raft request' (duration: 82.34858ms)","trace[342635960] 'compare' (duration: 294.190083ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:24:37.154829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:24:36.777594Z","time spent":"377.171435ms","remote":"127.0.0.1:33844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T18:24:37.154736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:24:36.791565Z","time spent":"363.168004ms","remote":"127.0.0.1:33672","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-08T18:24:37.154875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.197266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-061969a0-8826-483d-8652-c8985b485c30\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-08T18:24:37.154916Z","caller":"traceutil/trace.go:171","msg":"trace[2125025779] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-061969a0-8826-483d-8652-c8985b485c30; range_end:; response_count:1; response_revision:4475; }","duration":"367.277591ms","start":"2026-05-08T18:24:36.78763Z","end":"2026-05-08T18:24:37.154907Z","steps":["trace[2125025779] 'agreement among raft nodes before linearized reading' (duration: 367.119093ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:24:37.154884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.314571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T18:24:37.154941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:24:36.787614Z","time spent":"367.321382ms","remote":"127.0.0.1:33776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-061969a0-8826-483d-8652-c8985b485c30\" "} {"level":"info","ts":"2026-05-08T18:24:37.154965Z","caller":"traceutil/trace.go:171","msg":"trace[1194013061] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4475; }","duration":"339.398036ms","start":"2026-05-08T18:24:36.815544Z","end":"2026-05-08T18:24:37.154942Z","steps":["trace[1194013061] 'agreement among raft nodes before linearized reading' (duration: 339.274379ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:24:37.155004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:24:36.815496Z","time spent":"339.50114ms","remote":"127.0.0.1:33594","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-08T18:24:37.155031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.285223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-061969a0-8826-483d-8652-c8985b485c30\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-08T18:24:37.155055Z","caller":"traceutil/trace.go:171","msg":"trace[1543405864] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-061969a0-8826-483d-8652-c8985b485c30; range_end:; response_count:1; response_revision:4475; }","duration":"160.349776ms","start":"2026-05-08T18:24:36.994699Z","end":"2026-05-08T18:24:37.155049Z","steps":["trace[1543405864] 'agreement among raft nodes before linearized reading' (duration: 160.24172ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:24:37.155113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.590428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"} {"level":"info","ts":"2026-05-08T18:24:37.155137Z","caller":"traceutil/trace.go:171","msg":"trace[1731405973] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4475; }","duration":"162.673313ms","start":"2026-05-08T18:24:36.992456Z","end":"2026-05-08T18:24:37.155129Z","steps":["trace[1731405973] 'agreement among raft nodes before linearized reading' (duration: 162.540216ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:24:37.272503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.865722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:553"} {"level":"info","ts":"2026-05-08T18:24:37.272563Z","caller":"traceutil/trace.go:171","msg":"trace[21325666] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4477; }","duration":"114.963057ms","start":"2026-05-08T18:24:37.157587Z","end":"2026-05-08T18:24:37.27255Z","steps":["trace[21325666] 'agreement among raft nodes before linearized reading' (duration: 114.795139ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:24:37.272475Z","caller":"traceutil/trace.go:171","msg":"trace[303444117] transaction","detail":"{read_only:false; response_revision:4477; number_of_response:1; }","duration":"112.181889ms","start":"2026-05-08T18:24:37.160261Z","end":"2026-05-08T18:24:37.272443Z","steps":["trace[303444117] 'process raft request' (duration: 94.989334ms)","trace[303444117] 'compare' (duration: 17.041387ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:24:37.539681Z","caller":"traceutil/trace.go:171","msg":"trace[452721140] transaction","detail":"{read_only:false; response_revision:4482; number_of_response:1; }","duration":"220.451674ms","start":"2026-05-08T18:24:37.319208Z","end":"2026-05-08T18:24:37.53966Z","steps":["trace[452721140] 'process raft request' (duration: 220.191441ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:24:37.53972Z","caller":"traceutil/trace.go:171","msg":"trace[1695817001] transaction","detail":"{read_only:false; response_revision:4481; number_of_response:1; }","duration":"223.299455ms","start":"2026-05-08T18:24:37.316387Z","end":"2026-05-08T18:24:37.539686Z","steps":["trace[1695817001] 'process raft request' (duration: 127.004796ms)","trace[1695817001] 'compare' (duration: 95.761051ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:24:38.161494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.085622ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T18:24:38.16157Z","caller":"traceutil/trace.go:171","msg":"trace[1424949519] linearizableReadLoop","detail":"{readStateIndex:4673; appliedIndex:4672; }","duration":"412.080253ms","start":"2026-05-08T18:24:37.749479Z","end":"2026-05-08T18:24:38.161559Z","steps":["trace[1424949519] 'read index received' (duration: 180.77715ms)","trace[1424949519] 'applied index is now lower than readState.Index' (duration: 231.302303ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:24:38.161629Z","caller":"traceutil/trace.go:171","msg":"trace[527567891] transaction","detail":"{read_only:false; response_revision:4483; number_of_response:1; }","duration":"558.099214ms","start":"2026-05-08T18:24:37.603521Z","end":"2026-05-08T18:24:38.16162Z","steps":["trace[527567891] 'process raft request' (duration: 326.814852ms)","trace[527567891] 'compare' (duration: 230.997857ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:24:38.161675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:24:37.603495Z","time spent":"558.161127ms","remote":"127.0.0.1:33616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T18:24:38.161871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.399249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-05-08T18:24:38.161896Z","caller":"traceutil/trace.go:171","msg":"trace[1609935925] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:4483; }","duration":"412.42144ms","start":"2026-05-08T18:24:37.749466Z","end":"2026-05-08T18:24:38.161888Z","steps":["trace[1609935925] 'agreement among raft nodes before linearized reading' (duration: 412.330225ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:24:38.161913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:24:37.749419Z","time spent":"412.490084ms","remote":"127.0.0.1:33844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":549,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "} {"level":"warn","ts":"2026-05-08T18:24:38.162056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.59145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-68755575bf-pjtq6.18adaa4d48b8a467\" ","response":"range_response_count:1 size:898"} {"level":"info","ts":"2026-05-08T18:24:38.162107Z","caller":"traceutil/trace.go:171","msg":"trace[1886747178] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-68755575bf-pjtq6.18adaa4d48b8a467; range_end:; response_count:1; response_revision:4483; }","duration":"364.680715ms","start":"2026-05-08T18:24:37.797413Z","end":"2026-05-08T18:24:38.162094Z","steps":["trace[1886747178] 'agreement among raft nodes before linearized reading' (duration: 364.536868ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:24:38.16215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:24:37.797396Z","time spent":"364.749618ms","remote":"127.0.0.1:33672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":921,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-68755575bf-pjtq6.18adaa4d48b8a467\" "} {"level":"warn","ts":"2026-05-08T18:24:38.162298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.357149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18adaa4d1760c1a5\" ","response":"range_response_count:1 size:1012"} {"level":"info","ts":"2026-05-08T18:24:38.162319Z","caller":"traceutil/trace.go:171","msg":"trace[351325448] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18adaa4d1760c1a5; range_end:; response_count:1; response_revision:4483; }","duration":"217.413642ms","start":"2026-05-08T18:24:37.9449Z","end":"2026-05-08T18:24:38.162314Z","steps":["trace[351325448] 'agreement among raft nodes before linearized reading' (duration: 217.352329ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:24:49.701042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.465428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"} {"level":"info","ts":"2026-05-08T18:24:49.701127Z","caller":"traceutil/trace.go:171","msg":"trace[1464348811] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4658; }","duration":"263.585133ms","start":"2026-05-08T18:24:49.437521Z","end":"2026-05-08T18:24:49.701106Z","steps":["trace[1464348811] 'range keys from in-memory index tree' (duration: 263.234747ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:24:50.051853Z","caller":"traceutil/trace.go:171","msg":"trace[822257583] transaction","detail":"{read_only:false; response_revision:4664; number_of_response:1; }","duration":"113.559071ms","start":"2026-05-08T18:24:49.938268Z","end":"2026-05-08T18:24:50.051827Z","steps":["trace[822257583] 'process raft request' (duration: 113.09345ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:24:50.052053Z","caller":"traceutil/trace.go:171","msg":"trace[1550809960] transaction","detail":"{read_only:false; response_revision:4665; number_of_response:1; }","duration":"113.729679ms","start":"2026-05-08T18:24:49.938312Z","end":"2026-05-08T18:24:50.052042Z","steps":["trace[1550809960] 'process raft request' (duration: 113.150602ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:28:14.486563Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3258} {"level":"info","ts":"2026-05-08T18:28:14.579982Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3258,"took":"92.280538ms","hash":3354231865,"current-db-size-bytes":58494976,"current-db-size":"58 MB","current-db-size-in-use-bytes":32485376,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-08T18:28:14.580063Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3354231865,"revision":3258,"compact-revision":-1}