{"level":"warn","ts":"2026-04-06T17:06:41.689021Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-06T17:06:41.689117Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.233:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.233:2380","--initial-cluster=instance=https://199.204.45.233:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.233:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.233:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-06T17:06:41.689184Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-06T17:06:41.689195Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.233:2380"]} {"level":"info","ts":"2026-04-06T17:06:41.689211Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-06T17:06:41.689854Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"]} {"level":"info","ts":"2026-04-06T17:06:41.689943Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.233:2380"],"listen-peer-urls":["https://199.204.45.233:2380"],"advertise-client-urls":["https://199.204.45.233:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.233:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-06T17:06:41.694419Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.252873ms"} {"level":"info","ts":"2026-04-06T17:06:41.70363Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"90a0cb2044183f95","cluster-id":"782fef34d5ea94f9"} {"level":"info","ts":"2026-04-06T17:06:41.703784Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=()"} {"level":"info","ts":"2026-04-06T17:06:41.703822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became follower at term 0"} {"level":"info","ts":"2026-04-06T17:06:41.70385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 90a0cb2044183f95 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-06T17:06:41.703875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became follower at term 1"} {"level":"info","ts":"2026-04-06T17:06:41.703946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=(10421552877177159573)"} {"level":"warn","ts":"2026-04-06T17:06:41.711013Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-06T17:06:41.71255Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-06T17:06:41.714272Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-06T17:06:41.716755Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"90a0cb2044183f95","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-06T17:06:41.716975Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"90a0cb2044183f95","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-06T17:06:41.717396Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-06T17:06:41.717538Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-06T17:06:41.717565Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-06T17:06:41.719091Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=(10421552877177159573)"} {"level":"info","ts":"2026-04-06T17:06:41.72003Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"782fef34d5ea94f9","local-member-id":"90a0cb2044183f95","added-peer-id":"90a0cb2044183f95","added-peer-peer-urls":["https://199.204.45.233:2380"]} {"level":"info","ts":"2026-04-06T17:06:41.7221Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-06T17:06:41.722248Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.233:2380"} {"level":"info","ts":"2026-04-06T17:06:41.722318Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.233:2380"} {"level":"info","ts":"2026-04-06T17:06:41.722526Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"90a0cb2044183f95","initial-advertise-peer-urls":["https://199.204.45.233:2380"],"listen-peer-urls":["https://199.204.45.233:2380"],"advertise-client-urls":["https://199.204.45.233:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-06T17:06:41.722626Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-06T17:06:41.904793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 is starting a new election at term 1"} {"level":"info","ts":"2026-04-06T17:06:41.904871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-06T17:06:41.904925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 received MsgPreVoteResp from 90a0cb2044183f95 at term 1"} {"level":"info","ts":"2026-04-06T17:06:41.904952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became candidate at term 2"} {"level":"info","ts":"2026-04-06T17:06:41.904965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 received MsgVoteResp from 90a0cb2044183f95 at term 2"} {"level":"info","ts":"2026-04-06T17:06:41.904982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became leader at term 2"} {"level":"info","ts":"2026-04-06T17:06:41.905003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 90a0cb2044183f95 elected leader 90a0cb2044183f95 at term 2"} {"level":"info","ts":"2026-04-06T17:06:41.906211Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"90a0cb2044183f95","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.233:2379]}","request-path":"/0/members/90a0cb2044183f95/attributes","cluster-id":"782fef34d5ea94f9","publish-timeout":"7s"} {"level":"info","ts":"2026-04-06T17:06:41.906405Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-06T17:06:41.906464Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-06T17:06:41.907005Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T17:06:41.910029Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-06T17:06:41.910068Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-06T17:06:41.910254Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-06T17:06:41.910475Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.233:2379"} {"level":"info","ts":"2026-04-06T17:06:41.910652Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"782fef34d5ea94f9","local-member-id":"90a0cb2044183f95","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T17:06:41.910879Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T17:06:41.910936Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T17:07:19.52129Z","caller":"traceutil/trace.go:171","msg":"trace[2080323284] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"243.602656ms","start":"2026-04-06T17:07:19.277655Z","end":"2026-04-06T17:07:19.521258Z","steps":["trace[2080323284] 'process raft request' (duration: 243.419901ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:07:19.522154Z","caller":"traceutil/trace.go:171","msg":"trace[706726004] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"122.535013ms","start":"2026-04-06T17:07:19.3996Z","end":"2026-04-06T17:07:19.522135Z","steps":["trace[706726004] 'process raft request' (duration: 122.457811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:07:20.027367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.993857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T17:07:20.027544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.947105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-06T17:07:20.027607Z","caller":"traceutil/trace.go:171","msg":"trace[944818273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:621; }","duration":"132.070338ms","start":"2026-04-06T17:07:19.89552Z","end":"2026-04-06T17:07:20.02759Z","steps":["trace[944818273] 'range keys from in-memory index tree' (duration: 131.715229ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:07:20.027609Z","caller":"traceutil/trace.go:171","msg":"trace[1984687764] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"239.257484ms","start":"2026-04-06T17:07:19.788324Z","end":"2026-04-06T17:07:20.027582Z","steps":["trace[1984687764] 'range keys from in-memory index tree' (duration: 238.867453ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:08:01.497315Z","caller":"traceutil/trace.go:171","msg":"trace[1003778169] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"152.908809ms","start":"2026-04-06T17:08:01.344379Z","end":"2026-04-06T17:08:01.497288Z","steps":["trace[1003778169] 'process raft request' (duration: 152.741045ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:08:48.680588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.470228ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-06T17:08:48.68072Z","caller":"traceutil/trace.go:171","msg":"trace[2091097300] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"129.22446ms","start":"2026-04-06T17:08:48.551477Z","end":"2026-04-06T17:08:48.680702Z","steps":["trace[2091097300] 'compare' (duration: 121.285013ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:08:48.965253Z","caller":"traceutil/trace.go:171","msg":"trace[1177394111] linearizableReadLoop","detail":"{readStateIndex:1904; appliedIndex:1903; }","duration":"356.050966ms","start":"2026-04-06T17:08:48.609179Z","end":"2026-04-06T17:08:48.96523Z","steps":["trace[1177394111] 'read index received' (duration: 355.923443ms)","trace[1177394111] 'applied index is now lower than readState.Index' (duration: 126.323µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:08:48.965394Z","caller":"traceutil/trace.go:171","msg":"trace[1343729638] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"412.970426ms","start":"2026-04-06T17:08:48.552373Z","end":"2026-04-06T17:08:48.965344Z","steps":["trace[1343729638] 'process raft request' (duration: 412.707659ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:08:48.965418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.226031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-06T17:08:48.965561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:08:48.552353Z","time spent":"413.120841ms","remote":"127.0.0.1:46130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T17:08:48.965672Z","caller":"traceutil/trace.go:171","msg":"trace[1090273292] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1835; }","duration":"356.512529ms","start":"2026-04-06T17:08:48.609112Z","end":"2026-04-06T17:08:48.965624Z","steps":["trace[1090273292] 'agreement among raft nodes before linearized reading' (duration: 356.247022ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:08:48.965774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:08:48.609082Z","time spent":"356.653623ms","remote":"127.0.0.1:46040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-04-06T17:08:48.976858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.689044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10630"} {"level":"warn","ts":"2026-04-06T17:08:48.976883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.423421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T17:08:48.976925Z","caller":"traceutil/trace.go:171","msg":"trace[258394966] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1836; }","duration":"215.794327ms","start":"2026-04-06T17:08:48.761114Z","end":"2026-04-06T17:08:48.976908Z","steps":["trace[258394966] 'agreement among raft nodes before linearized reading' (duration: 215.611572ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:08:48.976947Z","caller":"traceutil/trace.go:171","msg":"trace[213422529] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1836; }","duration":"188.499364ms","start":"2026-04-06T17:08:48.788427Z","end":"2026-04-06T17:08:48.976926Z","steps":["trace[213422529] 'agreement among raft nodes before linearized reading' (duration: 188.406361ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:08:48.976985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.508504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T17:08:48.977062Z","caller":"traceutil/trace.go:171","msg":"trace[1553343371] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1836; }","duration":"188.624977ms","start":"2026-04-06T17:08:48.788416Z","end":"2026-04-06T17:08:48.977041Z","steps":["trace[1553343371] 'agreement among raft nodes before linearized reading' (duration: 188.510784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:08:48.977078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.671676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-06T17:08:48.977057Z","caller":"traceutil/trace.go:171","msg":"trace[1048731698] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"134.848992ms","start":"2026-04-06T17:08:48.842117Z","end":"2026-04-06T17:08:48.976966Z","steps":["trace[1048731698] 'process raft request' (duration: 134.494832ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:08:48.977137Z","caller":"traceutil/trace.go:171","msg":"trace[1068439954] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1836; }","duration":"196.791999ms","start":"2026-04-06T17:08:48.780328Z","end":"2026-04-06T17:08:48.97712Z","steps":["trace[1068439954] 'agreement among raft nodes before linearized reading' (duration: 196.592644ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:09:05.134025Z","caller":"traceutil/trace.go:171","msg":"trace[761723557] transaction","detail":"{read_only:false; response_revision:1973; number_of_response:1; }","duration":"109.468421ms","start":"2026-04-06T17:09:05.024522Z","end":"2026-04-06T17:09:05.13399Z","steps":["trace[761723557] 'process raft request' (duration: 109.149402ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:09:38.18149Z","caller":"traceutil/trace.go:171","msg":"trace[1812206232] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"141.478369ms","start":"2026-04-06T17:09:38.039974Z","end":"2026-04-06T17:09:38.181452Z","steps":["trace[1812206232] 'process raft request' (duration: 141.257493ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:09:38.415101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.967732ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-06T17:09:38.41537Z","caller":"traceutil/trace.go:171","msg":"trace[1218247071] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"228.385763ms","start":"2026-04-06T17:09:38.186966Z","end":"2026-04-06T17:09:38.415352Z","steps":["trace[1218247071] 'process raft request' (duration: 228.26874ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:09:38.415531Z","caller":"traceutil/trace.go:171","msg":"trace[635798027] linearizableReadLoop","detail":"{readStateIndex:2236; appliedIndex:2235; }","duration":"233.907724ms","start":"2026-04-06T17:09:38.181532Z","end":"2026-04-06T17:09:38.41544Z","steps":["trace[635798027] 'read index received' (duration: 123.572362ms)","trace[635798027] 'applied index is now lower than readState.Index' (duration: 110.331652ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:09:38.415567Z","caller":"traceutil/trace.go:171","msg":"trace[1249968277] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"254.173575ms","start":"2026-04-06T17:09:38.161364Z","end":"2026-04-06T17:09:38.415537Z","steps":["trace[1249968277] 'process raft request' (duration: 143.662049ms)","trace[1249968277] 'compare' (duration: 109.54867ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:09:38.415749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.203314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-04-06T17:09:38.41579Z","caller":"traceutil/trace.go:171","msg":"trace[2121729867] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2157; }","duration":"201.284886ms","start":"2026-04-06T17:09:38.214492Z","end":"2026-04-06T17:09:38.415777Z","steps":["trace[2121729867] 'agreement among raft nodes before linearized reading' (duration: 201.156122ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:09:38.415869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.194919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-06T17:09:38.415971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.707655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-06T17:09:38.416065Z","caller":"traceutil/trace.go:171","msg":"trace[1343461151] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2157; }","duration":"141.852999ms","start":"2026-04-06T17:09:38.274198Z","end":"2026-04-06T17:09:38.416051Z","steps":["trace[1343461151] 'agreement among raft nodes before linearized reading' (duration: 141.465899ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:09:38.415972Z","caller":"traceutil/trace.go:171","msg":"trace[973697783] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:2157; }","duration":"292.389495ms","start":"2026-04-06T17:09:38.123561Z","end":"2026-04-06T17:09:38.415951Z","steps":["trace[973697783] 'agreement among raft nodes before linearized reading' (duration: 292.033585ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:11:01.886469Z","caller":"traceutil/trace.go:171","msg":"trace[1448156740] transaction","detail":"{read_only:false; response_revision:2803; number_of_response:1; }","duration":"123.702366ms","start":"2026-04-06T17:11:01.762737Z","end":"2026-04-06T17:11:01.886439Z","steps":["trace[1448156740] 'process raft request' (duration: 123.495829ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:14:59.135088Z","caller":"traceutil/trace.go:171","msg":"trace[1116273238] transaction","detail":"{read_only:false; response_revision:4855; number_of_response:1; }","duration":"102.544971ms","start":"2026-04-06T17:14:59.032507Z","end":"2026-04-06T17:14:59.135052Z","steps":["trace[1116273238] 'process raft request' (duration: 102.356526ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:15:03.329048Z","caller":"traceutil/trace.go:171","msg":"trace[1301688455] transaction","detail":"{read_only:false; response_revision:5009; number_of_response:1; }","duration":"247.81728ms","start":"2026-04-06T17:15:03.081205Z","end":"2026-04-06T17:15:03.329023Z","steps":["trace[1301688455] 'process raft request' (duration: 186.333501ms)","trace[1301688455] 'compare' (duration: 61.304195ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:15:03.329015Z","caller":"traceutil/trace.go:171","msg":"trace[420896654] transaction","detail":"{read_only:false; response_revision:5010; number_of_response:1; }","duration":"123.480624ms","start":"2026-04-06T17:15:03.205517Z","end":"2026-04-06T17:15:03.328997Z","steps":["trace[420896654] 'process raft request' (duration: 123.432562ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:15:03.329406Z","caller":"traceutil/trace.go:171","msg":"trace[234658532] linearizableReadLoop","detail":"{readStateIndex:5196; appliedIndex:5195; }","duration":"167.798145ms","start":"2026-04-06T17:15:03.161592Z","end":"2026-04-06T17:15:03.32939Z","steps":["trace[234658532] 'read index received' (duration: 106.030427ms)","trace[234658532] 'applied index is now lower than readState.Index' (duration: 61.764187ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:15:03.329576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.97114ms","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-04-06T17:15:03.329608Z","caller":"traceutil/trace.go:171","msg":"trace[275790775] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5010; }","duration":"168.057172ms","start":"2026-04-06T17:15:03.161542Z","end":"2026-04-06T17:15:03.329599Z","steps":["trace[275790775] 'agreement among raft nodes before linearized reading' (duration: 167.921729ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:15:03.329595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.478732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-04-06T17:15:03.329689Z","caller":"traceutil/trace.go:171","msg":"trace[286550962] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5010; }","duration":"120.612565ms","start":"2026-04-06T17:15:03.209062Z","end":"2026-04-06T17:15:03.329674Z","steps":["trace[286550962] 'agreement among raft nodes before linearized reading' (duration: 120.445651ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:15:03.330074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.429814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-197739d8-0370-4461-bf84-92e3cf7930a4\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-06T17:15:03.330134Z","caller":"traceutil/trace.go:171","msg":"trace[992548717] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-197739d8-0370-4461-bf84-92e3cf7930a4; range_end:; response_count:1; response_revision:5010; }","duration":"141.524276ms","start":"2026-04-06T17:15:03.188592Z","end":"2026-04-06T17:15:03.330116Z","steps":["trace[992548717] 'agreement among raft nodes before linearized reading' (duration: 140.891789ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:15:13.964981Z","caller":"traceutil/trace.go:171","msg":"trace[1347582664] transaction","detail":"{read_only:false; response_revision:5220; number_of_response:1; }","duration":"108.157265ms","start":"2026-04-06T17:15:13.856796Z","end":"2026-04-06T17:15:13.964953Z","steps":["trace[1347582664] 'process raft request' (duration: 107.909668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:15:21.668957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.00678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3565"} {"level":"info","ts":"2026-04-06T17:15:21.669037Z","caller":"traceutil/trace.go:171","msg":"trace[221022062] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5389; }","duration":"213.135883ms","start":"2026-04-06T17:15:21.455881Z","end":"2026-04-06T17:15:21.669016Z","steps":["trace[221022062] 'range keys from in-memory index tree' (duration: 212.801594ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:15:21.874313Z","caller":"traceutil/trace.go:171","msg":"trace[1927701294] linearizableReadLoop","detail":"{readStateIndex:5590; appliedIndex:5589; }","duration":"115.28536ms","start":"2026-04-06T17:15:21.759002Z","end":"2026-04-06T17:15:21.874288Z","steps":["trace[1927701294] 'read index received' (duration: 62.9454ms)","trace[1927701294] 'applied index is now lower than readState.Index' (duration: 52.33889ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:15:21.874388Z","caller":"traceutil/trace.go:171","msg":"trace[1842686849] transaction","detail":"{read_only:false; response_revision:5391; number_of_response:1; }","duration":"141.27348ms","start":"2026-04-06T17:15:21.733088Z","end":"2026-04-06T17:15:21.874362Z","steps":["trace[1842686849] 'process raft request' (duration: 88.860778ms)","trace[1842686849] 'compare' (duration: 52.207906ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:15:21.874522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.276403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-b7tq2\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-06T17:15:21.874563Z","caller":"traceutil/trace.go:171","msg":"trace[667767772] range","detail":"{range_begin:/registry/pods/openstack/keepalived-b7tq2; range_end:; response_count:1; response_revision:5391; }","duration":"170.367145ms","start":"2026-04-06T17:15:21.704185Z","end":"2026-04-06T17:15:21.874552Z","steps":["trace[667767772] 'agreement among raft nodes before linearized reading' (duration: 170.231531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:15:21.874609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.155204ms","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:1346"} {"level":"info","ts":"2026-04-06T17:15:21.874675Z","caller":"traceutil/trace.go:171","msg":"trace[1978546851] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:5391; }","duration":"112.228267ms","start":"2026-04-06T17:15:21.762424Z","end":"2026-04-06T17:15:21.874653Z","steps":["trace[1978546851] 'agreement among raft nodes before linearized reading' (duration: 112.095593ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:15:22.03796Z","caller":"traceutil/trace.go:171","msg":"trace[2047904289] linearizableReadLoop","detail":"{readStateIndex:5591; appliedIndex:5590; }","duration":"154.406699ms","start":"2026-04-06T17:15:21.883497Z","end":"2026-04-06T17:15:22.037904Z","steps":["trace[2047904289] 'read index received' (duration: 141.822985ms)","trace[2047904289] 'applied index is now lower than readState.Index' (duration: 12.582693ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:15:22.038059Z","caller":"traceutil/trace.go:171","msg":"trace[1093687539] transaction","detail":"{read_only:false; response_revision:5392; number_of_response:1; }","duration":"155.390105ms","start":"2026-04-06T17:15:21.882636Z","end":"2026-04-06T17:15:22.038026Z","steps":["trace[1093687539] 'process raft request' (duration: 142.709649ms)","trace[1093687539] 'compare' (duration: 12.420369ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:15:22.038191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.675056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-04-06T17:15:22.03826Z","caller":"traceutil/trace.go:171","msg":"trace[154206877] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:5392; }","duration":"154.784469ms","start":"2026-04-06T17:15:21.883459Z","end":"2026-04-06T17:15:22.038244Z","steps":["trace[154206877] 'agreement among raft nodes before linearized reading' (duration: 154.576233ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:16:42.137983Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3023} {"level":"info","ts":"2026-04-06T17:16:42.220621Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3023,"took":"80.872517ms","hash":3118787064,"current-db-size-bytes":58744832,"current-db-size":"59 MB","current-db-size-in-use-bytes":31838208,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-06T17:16:42.220715Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3118787064,"revision":3023,"compact-revision":-1} {"level":"info","ts":"2026-04-06T17:21:19.978339Z","caller":"traceutil/trace.go:171","msg":"trace[1608476198] transaction","detail":"{read_only:false; response_revision:8184; number_of_response:1; }","duration":"102.299363ms","start":"2026-04-06T17:21:19.876007Z","end":"2026-04-06T17:21:19.978306Z","steps":["trace[1608476198] 'process raft request' (duration: 102.108618ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:21:20.127066Z","caller":"traceutil/trace.go:171","msg":"trace[584810292] transaction","detail":"{read_only:false; response_revision:8185; number_of_response:1; }","duration":"143.635332ms","start":"2026-04-06T17:21:19.983409Z","end":"2026-04-06T17:21:20.127044Z","steps":["trace[584810292] 'process raft request' (duration: 143.526099ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:21:20.12795Z","caller":"traceutil/trace.go:171","msg":"trace[188535117] transaction","detail":"{read_only:false; response_revision:8186; number_of_response:1; }","duration":"144.415293ms","start":"2026-04-06T17:21:19.983506Z","end":"2026-04-06T17:21:20.127922Z","steps":["trace[188535117] 'process raft request' (duration: 144.164406ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:21:32.786117Z","caller":"traceutil/trace.go:171","msg":"trace[1516095782] transaction","detail":"{read_only:false; response_revision:8256; number_of_response:1; }","duration":"259.434392ms","start":"2026-04-06T17:21:32.526655Z","end":"2026-04-06T17:21:32.78609Z","steps":["trace[1516095782] 'process raft request' (duration: 259.231177ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:21:42.144132Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6130} {"level":"info","ts":"2026-04-06T17:21:42.242127Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6130,"took":"95.876968ms","hash":711755533,"current-db-size-bytes":58744832,"current-db-size":"59 MB","current-db-size-in-use-bytes":23236608,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-06T17:21:42.242227Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":711755533,"revision":6130,"compact-revision":3023} {"level":"warn","ts":"2026-04-06T17:22:00.816132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.540619ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-06T17:22:00.816303Z","caller":"traceutil/trace.go:171","msg":"trace[694925780] linearizableReadLoop","detail":"{readStateIndex:8755; appliedIndex:8753; }","duration":"471.041149ms","start":"2026-04-06T17:22:00.34524Z","end":"2026-04-06T17:22:00.816281Z","steps":["trace[694925780] 'read index received' (duration: 5.614873ms)","trace[694925780] 'applied index is now lower than readState.Index' (duration: 465.424236ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:22:00.816781Z","caller":"traceutil/trace.go:171","msg":"trace[1434682207] transaction","detail":"{read_only:false; response_revision:8458; number_of_response:1; }","duration":"472.124198ms","start":"2026-04-06T17:22:00.344628Z","end":"2026-04-06T17:22:00.816753Z","steps":["trace[1434682207] 'process raft request' (duration: 268.86201ms)","trace[1434682207] 'compare' (duration: 202.082836ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:22:00.816786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.538413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-04-06T17:22:00.816805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.812594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-06T17:22:00.816866Z","caller":"traceutil/trace.go:171","msg":"trace[1645001558] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8458; }","duration":"471.703417ms","start":"2026-04-06T17:22:00.345142Z","end":"2026-04-06T17:22:00.816845Z","steps":["trace[1645001558] 'agreement among raft nodes before linearized reading' (duration: 471.481091ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:22:00.816883Z","caller":"traceutil/trace.go:171","msg":"trace[1587599486] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8458; }","duration":"288.930388ms","start":"2026-04-06T17:22:00.527935Z","end":"2026-04-06T17:22:00.816865Z","steps":["trace[1587599486] 'agreement among raft nodes before linearized reading' (duration: 288.680571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:22:00.816911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:22:00.345111Z","time spent":"471.79148ms","remote":"127.0.0.1:46130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-06T17:22:00.816906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:22:00.344615Z","time spent":"472.230461ms","remote":"127.0.0.1:46130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T17:22:12.5474Z","caller":"traceutil/trace.go:171","msg":"trace[2141959186] linearizableReadLoop","detail":"{readStateIndex:8864; appliedIndex:8863; }","duration":"142.774388ms","start":"2026-04-06T17:22:12.404597Z","end":"2026-04-06T17:22:12.547372Z","steps":["trace[2141959186] 'read index received' (duration: 97.833201ms)","trace[2141959186] 'applied index is now lower than readState.Index' (duration: 44.940207ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:22:12.547513Z","caller":"traceutil/trace.go:171","msg":"trace[1137587528] transaction","detail":"{read_only:false; response_revision:8562; number_of_response:1; }","duration":"143.22875ms","start":"2026-04-06T17:22:12.404253Z","end":"2026-04-06T17:22:12.547481Z","steps":["trace[1137587528] 'process raft request' (duration: 98.256682ms)","trace[1137587528] 'compare' (duration: 44.721421ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:22:12.547745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.518963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-06T17:22:12.547724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.098627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-detect-version\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-04-06T17:22:12.547808Z","caller":"traceutil/trace.go:171","msg":"trace[1445689155] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8562; }","duration":"130.630876ms","start":"2026-04-06T17:22:12.417161Z","end":"2026-04-06T17:22:12.547792Z","steps":["trace[1445689155] 'agreement among raft nodes before linearized reading' (duration: 130.374309ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:22:12.547825Z","caller":"traceutil/trace.go:171","msg":"trace[2043473747] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-detect-version; range_end:; response_count:1; response_revision:8562; }","duration":"143.22804ms","start":"2026-04-06T17:22:12.404577Z","end":"2026-04-06T17:22:12.547805Z","steps":["trace[2043473747] 'agreement among raft nodes before linearized reading' (duration: 142.928562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:22:13.302841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.761432ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-06T17:22:13.302969Z","caller":"traceutil/trace.go:171","msg":"trace[1994888635] transaction","detail":"{read_only:false; response_revision:8568; number_of_response:1; }","duration":"239.720554ms","start":"2026-04-06T17:22:13.063223Z","end":"2026-04-06T17:22:13.302944Z","steps":["trace[1994888635] 'process raft request' (duration: 109.732656ms)","trace[1994888635] 'compare' (duration: 129.461094ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:22:13.330281Z","caller":"traceutil/trace.go:171","msg":"trace[259396174] transaction","detail":"{read_only:false; response_revision:8570; number_of_response:1; }","duration":"264.297725ms","start":"2026-04-06T17:22:13.065957Z","end":"2026-04-06T17:22:13.330254Z","steps":["trace[259396174] 'process raft request' (duration: 264.200232ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:22:13.330313Z","caller":"traceutil/trace.go:171","msg":"trace[4686204] linearizableReadLoop","detail":"{readStateIndex:8873; appliedIndex:8870; }","duration":"104.723859ms","start":"2026-04-06T17:22:13.225565Z","end":"2026-04-06T17:22:13.330289Z","steps":["trace[4686204] 'read index received' (duration: 104.530303ms)","trace[4686204] 'applied index is now lower than readState.Index' (duration: 192.436µs)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:22:13.330511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.947475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-06T17:22:13.330555Z","caller":"traceutil/trace.go:171","msg":"trace[2144502089] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8571; }","duration":"105.060498ms","start":"2026-04-06T17:22:13.225483Z","end":"2026-04-06T17:22:13.330543Z","steps":["trace[2144502089] 'agreement among raft nodes before linearized reading' (duration: 104.894223ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:22:13.330774Z","caller":"traceutil/trace.go:171","msg":"trace[360170544] transaction","detail":"{read_only:false; response_revision:8571; number_of_response:1; }","duration":"251.183657ms","start":"2026-04-06T17:22:13.079579Z","end":"2026-04-06T17:22:13.330763Z","steps":["trace[360170544] 'process raft request' (duration: 250.631652ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:22:13.330758Z","caller":"traceutil/trace.go:171","msg":"trace[1415794675] transaction","detail":"{read_only:false; response_revision:8569; number_of_response:1; }","duration":"264.738287ms","start":"2026-04-06T17:22:13.065957Z","end":"2026-04-06T17:22:13.330695Z","steps":["trace[1415794675] 'process raft request' (duration: 263.970436ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:23:02.652344Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002498.wal"} {"level":"info","ts":"2026-04-06T17:24:18.205926Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"90a0cb2044183f95","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-06T17:24:18.211305Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-06T17:24:18.211379Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-06T17:26:42.152029Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8311} {"level":"info","ts":"2026-04-06T17:26:42.225961Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8311,"took":"71.854269ms","hash":2524937650,"current-db-size-bytes":58744832,"current-db-size":"59 MB","current-db-size-in-use-bytes":24891392,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-06T17:26:42.226032Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2524937650,"revision":8311,"compact-revision":6130} {"level":"info","ts":"2026-04-06T17:28:14.995345Z","caller":"traceutil/trace.go:171","msg":"trace[1393632246] transaction","detail":"{read_only:false; response_revision:11194; number_of_response:1; }","duration":"287.828441ms","start":"2026-04-06T17:28:14.707492Z","end":"2026-04-06T17:28:14.99532Z","steps":["trace[1393632246] 'process raft request' (duration: 287.673917ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:28:15.00119Z","caller":"traceutil/trace.go:171","msg":"trace[1462963231] linearizableReadLoop","detail":"{readStateIndex:11583; appliedIndex:11581; }","duration":"211.91443ms","start":"2026-04-06T17:28:14.789246Z","end":"2026-04-06T17:28:15.00116Z","steps":["trace[1462963231] 'read index received' (duration: 205.956898ms)","trace[1462963231] 'applied index is now lower than readState.Index' (duration: 5.956292ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:28:15.001353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.104575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T17:28:15.001392Z","caller":"traceutil/trace.go:171","msg":"trace[995400035] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11195; }","duration":"212.208478ms","start":"2026-04-06T17:28:14.789174Z","end":"2026-04-06T17:28:15.001383Z","steps":["trace[995400035] 'agreement among raft nodes before linearized reading' (duration: 212.128036ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:28:15.001363Z","caller":"traceutil/trace.go:171","msg":"trace[65033834] transaction","detail":"{read_only:false; response_revision:11195; number_of_response:1; }","duration":"290.764111ms","start":"2026-04-06T17:28:14.710541Z","end":"2026-04-06T17:28:15.001305Z","steps":["trace[65033834] 'process raft request' (duration: 290.477893ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:28:15.001491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.750944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-b7tq2\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-04-06T17:28:15.001544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.727764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-06T17:28:15.001737Z","caller":"traceutil/trace.go:171","msg":"trace[1549834315] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11195; }","duration":"128.008752ms","start":"2026-04-06T17:28:14.873719Z","end":"2026-04-06T17:28:15.001728Z","steps":["trace[1549834315] 'agreement among raft nodes before linearized reading' (duration: 127.688223ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:28:15.001822Z","caller":"traceutil/trace.go:171","msg":"trace[997344050] range","detail":"{range_begin:/registry/pods/openstack/keepalived-b7tq2; range_end:; response_count:1; response_revision:11195; }","duration":"153.96831ms","start":"2026-04-06T17:28:14.847639Z","end":"2026-04-06T17:28:15.001607Z","steps":["trace[997344050] 'agreement among raft nodes before linearized reading' (duration: 153.678552ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:31:42.157884Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10704} {"level":"info","ts":"2026-04-06T17:31:42.234177Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10704,"took":"74.073802ms","hash":1327111087,"current-db-size-bytes":58744832,"current-db-size":"59 MB","current-db-size-in-use-bytes":20488192,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-06T17:31:42.234293Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1327111087,"revision":10704,"compact-revision":8311}