{"level":"warn","ts":"2026-09-29T15:28:50.721004Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-29T15:28:50.721135Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.79:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.79:2380","--initial-cluster=instance=https://162.253.55.79:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.79:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.79:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-29T15:28:50.721213Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-29T15:28:50.721242Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.79:2380"]} {"level":"info","ts":"2026-09-29T15:28:50.721271Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-29T15:28:50.721846Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"]} {"level":"info","ts":"2026-09-29T15:28:50.721931Z","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://162.253.55.79:2380"],"listen-peer-urls":["https://162.253.55.79:2380"],"advertise-client-urls":["https://162.253.55.79:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.79:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-29T15:28:50.727274Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.087295ms"} {"level":"info","ts":"2026-09-29T15:28:50.739309Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"401ca643156fc5da","cluster-id":"e9f568c3681bb0d0"} {"level":"info","ts":"2026-09-29T15:28:50.73937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=()"} {"level":"info","ts":"2026-09-29T15:28:50.73939Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became follower at term 0"} {"level":"info","ts":"2026-09-29T15:28:50.739398Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 401ca643156fc5da [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-29T15:28:50.73941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became follower at term 1"} {"level":"info","ts":"2026-09-29T15:28:50.73944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=(4619750124827952602)"} {"level":"warn","ts":"2026-09-29T15:28:50.746907Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-29T15:28:50.748253Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-29T15:28:50.749417Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-29T15:28:50.7512Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"401ca643156fc5da","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-29T15:28:50.754918Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-29T15:28:50.755577Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.79:2380"} {"level":"info","ts":"2026-09-29T15:28:50.755629Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.79:2380"} {"level":"info","ts":"2026-09-29T15:28:50.756325Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"401ca643156fc5da","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-29T15:28:50.756469Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"401ca643156fc5da","initial-advertise-peer-urls":["https://162.253.55.79:2380"],"listen-peer-urls":["https://162.253.55.79:2380"],"advertise-client-urls":["https://162.253.55.79:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-29T15:28:50.756506Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-29T15:28:50.756615Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-29T15:28:50.756661Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-29T15:28:50.75667Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-29T15:28:50.757249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=(4619750124827952602)"} {"level":"info","ts":"2026-09-29T15:28:50.757356Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e9f568c3681bb0d0","local-member-id":"401ca643156fc5da","added-peer-id":"401ca643156fc5da","added-peer-peer-urls":["https://162.253.55.79:2380"]} {"level":"info","ts":"2026-09-29T15:28:50.840426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da is starting a new election at term 1"} {"level":"info","ts":"2026-09-29T15:28:50.840485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became pre-candidate at term 1"} {"level":"info","ts":"2026-09-29T15:28:50.840517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da received MsgPreVoteResp from 401ca643156fc5da at term 1"} {"level":"info","ts":"2026-09-29T15:28:50.840536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became candidate at term 2"} {"level":"info","ts":"2026-09-29T15:28:50.840552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da received MsgVoteResp from 401ca643156fc5da at term 2"} {"level":"info","ts":"2026-09-29T15:28:50.840572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became leader at term 2"} {"level":"info","ts":"2026-09-29T15:28:50.84059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 401ca643156fc5da elected leader 401ca643156fc5da at term 2"} {"level":"info","ts":"2026-09-29T15:28:50.841617Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T15:28:50.842666Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"401ca643156fc5da","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.79:2379]}","request-path":"/0/members/401ca643156fc5da/attributes","cluster-id":"e9f568c3681bb0d0","publish-timeout":"7s"} {"level":"info","ts":"2026-09-29T15:28:50.842951Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-29T15:28:50.843033Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-29T15:28:50.844173Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e9f568c3681bb0d0","local-member-id":"401ca643156fc5da","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T15:28:50.844304Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T15:28:50.844345Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T15:28:50.844469Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-29T15:28:50.844529Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-29T15:28:50.84705Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-29T15:28:50.847304Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.79:2379"} {"level":"warn","ts":"2026-09-29T15:29:02.767795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.537498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-29T15:29:02.767948Z","caller":"traceutil/trace.go:171","msg":"trace[1482335508] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:349; }","duration":"195.755451ms","start":"2026-09-29T15:29:02.572169Z","end":"2026-09-29T15:29:02.767925Z","steps":["trace[1482335508] 'range keys from in-memory index tree' (duration: 195.24599ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:29:35.059427Z","caller":"traceutil/trace.go:171","msg":"trace[782021797] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"145.04507ms","start":"2026-09-29T15:29:34.914209Z","end":"2026-09-29T15:29:35.059254Z","steps":["trace[782021797] 'process raft request' (duration: 138.76786ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:29:35.632033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.112123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-29T15:29:35.632123Z","caller":"traceutil/trace.go:171","msg":"trace[879122691] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:598; }","duration":"266.209686ms","start":"2026-09-29T15:29:35.365886Z","end":"2026-09-29T15:29:35.632096Z","steps":["trace[879122691] 'range keys from in-memory index tree' (duration: 265.821271ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:29:35.646041Z","caller":"traceutil/trace.go:171","msg":"trace[55233642] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"202.640664ms","start":"2026-09-29T15:29:35.443341Z","end":"2026-09-29T15:29:35.645981Z","steps":["trace[55233642] 'process raft request' (duration: 202.092872ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:29:52.76531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.939399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T15:29:52.7654Z","caller":"traceutil/trace.go:171","msg":"trace[1381164526] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:763; }","duration":"152.134626ms","start":"2026-09-29T15:29:52.613246Z","end":"2026-09-29T15:29:52.765381Z","steps":["trace[1381164526] 'range keys from in-memory index tree' (duration: 151.823335ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:29:52.765353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.394172ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T15:29:52.765497Z","caller":"traceutil/trace.go:171","msg":"trace[100978981] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:763; }","duration":"319.548147ms","start":"2026-09-29T15:29:52.445931Z","end":"2026-09-29T15:29:52.76548Z","steps":["trace[100978981] 'range keys from in-memory index tree' (duration: 319.381412ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:29:52.765542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.569094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-jb9r9\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-09-29T15:29:52.765593Z","caller":"traceutil/trace.go:171","msg":"trace[171739932] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-jb9r9; range_end:; response_count:1; response_revision:763; }","duration":"179.657667ms","start":"2026-09-29T15:29:52.58592Z","end":"2026-09-29T15:29:52.765577Z","steps":["trace[171739932] 'range keys from in-memory index tree' (duration: 179.395888ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:30:43.687275Z","caller":"traceutil/trace.go:171","msg":"trace[1597325167] transaction","detail":"{read_only:false; response_revision:1411; number_of_response:1; }","duration":"177.711956ms","start":"2026-09-29T15:30:43.509523Z","end":"2026-09-29T15:30:43.687235Z","steps":["trace[1597325167] 'process raft request' (duration: 177.347319ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:30:46.042098Z","caller":"traceutil/trace.go:171","msg":"trace[243186134] transaction","detail":"{read_only:false; response_revision:1425; number_of_response:1; }","duration":"132.789169ms","start":"2026-09-29T15:30:45.909287Z","end":"2026-09-29T15:30:46.042076Z","steps":["trace[243186134] 'process raft request' (duration: 132.637455ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:31:12.290708Z","caller":"traceutil/trace.go:171","msg":"trace[464265773] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"262.217583ms","start":"2026-09-29T15:31:12.028465Z","end":"2026-09-29T15:31:12.290683Z","steps":["trace[464265773] 'process raft request' (duration: 261.964879ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:31:12.675219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.048684ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T15:31:12.675437Z","caller":"traceutil/trace.go:171","msg":"trace[1492415179] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1836; }","duration":"230.290808ms","start":"2026-09-29T15:31:12.445121Z","end":"2026-09-29T15:31:12.675412Z","steps":["trace[1492415179] 'range keys from in-memory index tree' (duration: 230.023634ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:31:12.675539Z","caller":"traceutil/trace.go:171","msg":"trace[553892103] linearizableReadLoop","detail":"{readStateIndex:1910; appliedIndex:1908; }","duration":"472.176168ms","start":"2026-09-29T15:31:12.203288Z","end":"2026-09-29T15:31:12.675465Z","steps":["trace[553892103] 'read index received' (duration: 87.155403ms)","trace[553892103] 'applied index is now lower than readState.Index' (duration: 385.019305ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:31:12.675966Z","caller":"traceutil/trace.go:171","msg":"trace[1920249203] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"525.629367ms","start":"2026-09-29T15:31:12.150291Z","end":"2026-09-29T15:31:12.67592Z","steps":["trace[1920249203] 'process raft request' (duration: 469.40318ms)","trace[1920249203] 'compare' (duration: 55.617536ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:31:12.676085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.785469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-29T15:31:12.676126Z","caller":"traceutil/trace.go:171","msg":"trace[797306270] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1837; }","duration":"472.87332ms","start":"2026-09-29T15:31:12.203241Z","end":"2026-09-29T15:31:12.676114Z","steps":["trace[797306270] 'agreement among raft nodes before linearized reading' (duration: 472.568325ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:31:12.676168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:31:12.203215Z","time spent":"472.944962ms","remote":"127.0.0.1:40690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-29T15:31:12.676819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:31:12.150262Z","time spent":"525.779239ms","remote":"127.0.0.1:40690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-29T15:31:12.768841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.825825ms","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-09-29T15:31:12.768954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.715076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T15:31:12.769081Z","caller":"traceutil/trace.go:171","msg":"trace[726634598] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1838; }","duration":"154.853119ms","start":"2026-09-29T15:31:12.614212Z","end":"2026-09-29T15:31:12.769065Z","steps":["trace[726634598] 'agreement among raft nodes before linearized reading' (duration: 154.720977ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:31:12.769165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.930459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10629"} {"level":"info","ts":"2026-09-29T15:31:12.769265Z","caller":"traceutil/trace.go:171","msg":"trace[501828322] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1838; }","duration":"473.98348ms","start":"2026-09-29T15:31:12.295219Z","end":"2026-09-29T15:31:12.769202Z","steps":["trace[501828322] 'agreement among raft nodes before linearized reading' (duration: 473.792116ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:31:12.769056Z","caller":"traceutil/trace.go:171","msg":"trace[1456527540] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1838; }","duration":"251.09219ms","start":"2026-09-29T15:31:12.517942Z","end":"2026-09-29T15:31:12.769034Z","steps":["trace[1456527540] 'agreement among raft nodes before linearized reading' (duration: 250.794995ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:31:12.769456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.15437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-09-29T15:31:12.769549Z","caller":"traceutil/trace.go:171","msg":"trace[945830978] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1838; }","duration":"566.271222ms","start":"2026-09-29T15:31:12.203264Z","end":"2026-09-29T15:31:12.769536Z","steps":["trace[945830978] 'agreement among raft nodes before linearized reading' (duration: 566.097059ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:31:12.768883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.231184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"warn","ts":"2026-09-29T15:31:12.769629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:31:12.203245Z","time spent":"566.373884ms","remote":"127.0.0.1:40690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-29T15:31:12.770054Z","caller":"traceutil/trace.go:171","msg":"trace[914280623] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1838; }","duration":"198.461806ms","start":"2026-09-29T15:31:12.571575Z","end":"2026-09-29T15:31:12.770037Z","steps":["trace[914280623] 'agreement among raft nodes before linearized reading' (duration: 197.123153ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:31:12.76931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:31:12.295139Z","time spent":"474.159902ms","remote":"127.0.0.1:40586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":10652,"request content":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" "} {"level":"info","ts":"2026-09-29T15:31:12.768917Z","caller":"traceutil/trace.go:171","msg":"trace[1128141330] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"448.342885ms","start":"2026-09-29T15:31:12.320546Z","end":"2026-09-29T15:31:12.768889Z","steps":["trace[1128141330] 'process raft request' (duration: 447.952138ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:31:12.770531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:31:12.320525Z","time spent":"449.877201ms","remote":"127.0.0.1:40690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-29T15:31:12.996528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.678729ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-29T15:31:12.996767Z","caller":"traceutil/trace.go:171","msg":"trace[358764138] linearizableReadLoop","detail":"{readStateIndex:1912; appliedIndex:1911; }","duration":"228.055019ms","start":"2026-09-29T15:31:12.76869Z","end":"2026-09-29T15:31:12.996745Z","steps":["trace[358764138] 'read index received' (duration: 73.75803ms)","trace[358764138] 'applied index is now lower than readState.Index' (duration: 154.295069ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:31:12.997006Z","caller":"traceutil/trace.go:171","msg":"trace[618136383] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"315.964256ms","start":"2026-09-29T15:31:12.680992Z","end":"2026-09-29T15:31:12.996957Z","steps":["trace[618136383] 'process raft request' (duration: 161.454373ms)","trace[618136383] 'compare' (duration: 153.122409ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:31:12.997261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.289228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2743438d-85eb-4e9d-b4ed-8b8cc63b4551\" ","response":"range_response_count:1 size:3743"} {"level":"info","ts":"2026-09-29T15:31:12.997342Z","caller":"traceutil/trace.go:171","msg":"trace[1229695808] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2743438d-85eb-4e9d-b4ed-8b8cc63b4551; range_end:; response_count:1; response_revision:1839; }","duration":"234.509491ms","start":"2026-09-29T15:31:12.762815Z","end":"2026-09-29T15:31:12.997324Z","steps":["trace[1229695808] 'agreement among raft nodes before linearized reading' (duration: 234.060984ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:31:12.997648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:31:12.680967Z","time spent":"316.1357ms","remote":"127.0.0.1:40690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-29T15:31:13.020046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.506321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T15:31:13.020105Z","caller":"traceutil/trace.go:171","msg":"trace[730404961] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1842; }","duration":"249.680424ms","start":"2026-09-29T15:31:12.770412Z","end":"2026-09-29T15:31:13.020092Z","steps":["trace[730404961] 'agreement among raft nodes before linearized reading' (duration: 249.576882ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:31:13.020192Z","caller":"traceutil/trace.go:171","msg":"trace[1283523861] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"245.194595ms","start":"2026-09-29T15:31:12.774973Z","end":"2026-09-29T15:31:13.020168Z","steps":["trace[1283523861] 'process raft request' (duration: 244.706537ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:31:13.020357Z","caller":"traceutil/trace.go:171","msg":"trace[1637047238] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"243.437595ms","start":"2026-09-29T15:31:12.776904Z","end":"2026-09-29T15:31:13.020341Z","steps":["trace[1637047238] 'process raft request' (duration: 242.917096ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:31:13.020828Z","caller":"traceutil/trace.go:171","msg":"trace[1990852545] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"237.547902ms","start":"2026-09-29T15:31:12.783265Z","end":"2026-09-29T15:31:13.020813Z","steps":["trace[1990852545] 'process raft request' (duration: 236.658317ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:31:13.28723Z","caller":"traceutil/trace.go:171","msg":"trace[1880408166] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"259.008641ms","start":"2026-09-29T15:31:13.028191Z","end":"2026-09-29T15:31:13.287199Z","steps":["trace[1880408166] 'process raft request' (duration: 220.538677ms)","trace[1880408166] 'compare' (duration: 38.28491ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:31:13.287269Z","caller":"traceutil/trace.go:171","msg":"trace[1980934766] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"258.250757ms","start":"2026-09-29T15:31:13.028996Z","end":"2026-09-29T15:31:13.287247Z","steps":["trace[1980934766] 'process raft request' (duration: 258.181596ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:31:13.287547Z","caller":"traceutil/trace.go:171","msg":"trace[334503732] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"259.135773ms","start":"2026-09-29T15:31:13.028307Z","end":"2026-09-29T15:31:13.287442Z","steps":["trace[334503732] 'process raft request' (duration: 258.814567ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:31:13.287748Z","caller":"traceutil/trace.go:171","msg":"trace[1990036684] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"130.131637ms","start":"2026-09-29T15:31:13.157604Z","end":"2026-09-29T15:31:13.287735Z","steps":["trace[1990036684] 'process raft request' (duration: 129.945024ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:31:13.287899Z","caller":"traceutil/trace.go:171","msg":"trace[1191237133] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"258.834257ms","start":"2026-09-29T15:31:13.02904Z","end":"2026-09-29T15:31:13.287874Z","steps":["trace[1191237133] 'process raft request' (duration: 258.191906ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:31:27.315947Z","caller":"traceutil/trace.go:171","msg":"trace[827768471] transaction","detail":"{read_only:false; response_revision:1969; number_of_response:1; }","duration":"185.04909ms","start":"2026-09-29T15:31:27.130865Z","end":"2026-09-29T15:31:27.315914Z","steps":["trace[827768471] 'process raft request' (duration: 182.091152ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:32:01.595293Z","caller":"traceutil/trace.go:171","msg":"trace[124469032] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"263.215519ms","start":"2026-09-29T15:32:01.332047Z","end":"2026-09-29T15:32:01.595262Z","steps":["trace[124469032] 'process raft request' (duration: 263.023366ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:32:01.868528Z","caller":"traceutil/trace.go:171","msg":"trace[1349588904] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"536.311684ms","start":"2026-09-29T15:32:01.332151Z","end":"2026-09-29T15:32:01.868462Z","steps":["trace[1349588904] 'process raft request' (duration: 442.787974ms)","trace[1349588904] 'compare' (duration: 93.141655ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:32:01.868894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:32:01.332107Z","time spent":"536.525378ms","remote":"127.0.0.1:40690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T15:32:01.868972Z","caller":"traceutil/trace.go:171","msg":"trace[93793241] linearizableReadLoop","detail":"{readStateIndex:2243; appliedIndex:2240; }","duration":"376.490675ms","start":"2026-09-29T15:32:01.492458Z","end":"2026-09-29T15:32:01.868949Z","steps":["trace[93793241] 'read index received' (duration: 102.76009ms)","trace[93793241] 'applied index is now lower than readState.Index' (duration: 273.729505ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:32:01.869206Z","caller":"traceutil/trace.go:171","msg":"trace[343331265] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"428.27711ms","start":"2026-09-29T15:32:01.440905Z","end":"2026-09-29T15:32:01.869183Z","steps":["trace[343331265] 'process raft request' (duration: 427.322337ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:32:01.869369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.772278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-29T15:32:01.869372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.896401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"warn","ts":"2026-09-29T15:32:01.869356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:32:01.440885Z","time spent":"428.359711ms","remote":"127.0.0.1:40690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T15:32:01.869439Z","caller":"traceutil/trace.go:171","msg":"trace[1898793502] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2159; }","duration":"256.853249ms","start":"2026-09-29T15:32:01.612559Z","end":"2026-09-29T15:32:01.869412Z","steps":["trace[1898793502] 'agreement among raft nodes before linearized reading' (duration: 256.749827ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:32:01.869446Z","caller":"traceutil/trace.go:171","msg":"trace[1310744745] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2159; }","duration":"377.080473ms","start":"2026-09-29T15:32:01.492342Z","end":"2026-09-29T15:32:01.869423Z","steps":["trace[1310744745] 'agreement among raft nodes before linearized reading' (duration: 376.87006ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:32:01.869492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:32:01.492257Z","time spent":"377.221986ms","remote":"127.0.0.1:40690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":594,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-09-29T15:32:01.869653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.212499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-09-29T15:32:01.869721Z","caller":"traceutil/trace.go:171","msg":"trace[230946745] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2159; }","duration":"368.333291ms","start":"2026-09-29T15:32:01.501367Z","end":"2026-09-29T15:32:01.8697Z","steps":["trace[230946745] 'agreement among raft nodes before linearized reading' (duration: 367.907545ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:32:01.870002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:32:01.501346Z","time spent":"368.637505ms","remote":"127.0.0.1:40690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-09-29T15:32:01.869936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.567556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-29T15:32:01.870277Z","caller":"traceutil/trace.go:171","msg":"trace[1143263416] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2159; }","duration":"326.935691ms","start":"2026-09-29T15:32:01.543322Z","end":"2026-09-29T15:32:01.870257Z","steps":["trace[1143263416] 'agreement among raft nodes before linearized reading' (duration: 326.049568ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:32:01.870332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:32:01.543308Z","time spent":"327.007981ms","remote":"127.0.0.1:40690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-29T15:33:18.05502Z","caller":"traceutil/trace.go:171","msg":"trace[1305830772] transaction","detail":"{read_only:false; response_revision:2659; number_of_response:1; }","duration":"358.233499ms","start":"2026-09-29T15:33:17.696732Z","end":"2026-09-29T15:33:18.054965Z","steps":["trace[1305830772] 'process raft request' (duration: 357.646493ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:33:18.055507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:33:17.696691Z","time spent":"358.447695ms","remote":"127.0.0.1:40690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T15:33:50.392066Z","caller":"traceutil/trace.go:171","msg":"trace[1207295429] transaction","detail":"{read_only:false; response_revision:2835; number_of_response:1; }","duration":"165.919534ms","start":"2026-09-29T15:33:50.226113Z","end":"2026-09-29T15:33:50.392032Z","steps":["trace[1207295429] 'process raft request' (duration: 165.686598ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:33:50.392133Z","caller":"traceutil/trace.go:171","msg":"trace[30233306] linearizableReadLoop","detail":"{readStateIndex:2943; appliedIndex:2943; }","duration":"163.021552ms","start":"2026-09-29T15:33:50.229055Z","end":"2026-09-29T15:33:50.392077Z","steps":["trace[30233306] 'read index received' (duration: 163.003631ms)","trace[30233306] 'applied index is now lower than readState.Index' (duration: 15.061µs)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:33:50.392496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.372581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-29T15:33:50.392559Z","caller":"traceutil/trace.go:171","msg":"trace[1528849505] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2835; }","duration":"163.496153ms","start":"2026-09-29T15:33:50.229043Z","end":"2026-09-29T15:33:50.392539Z","steps":["trace[1528849505] 'agreement among raft nodes before linearized reading' (duration: 163.188856ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:33:50.408046Z","caller":"traceutil/trace.go:171","msg":"trace[1298854311] transaction","detail":"{read_only:false; response_revision:2836; number_of_response:1; }","duration":"173.783931ms","start":"2026-09-29T15:33:50.234241Z","end":"2026-09-29T15:33:50.408025Z","steps":["trace[1298854311] 'process raft request' (duration: 173.516324ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:33:50.408296Z","caller":"traceutil/trace.go:171","msg":"trace[592001740] transaction","detail":"{read_only:false; response_revision:2837; number_of_response:1; }","duration":"158.249032ms","start":"2026-09-29T15:33:50.250028Z","end":"2026-09-29T15:33:50.408277Z","steps":["trace[592001740] 'process raft request' (duration: 157.922764ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:38:30.269398Z","caller":"traceutil/trace.go:171","msg":"trace[915209171] transaction","detail":"{read_only:false; response_revision:4808; number_of_response:1; }","duration":"169.285551ms","start":"2026-09-29T15:38:30.10008Z","end":"2026-09-29T15:38:30.269366Z","steps":["trace[915209171] 'process raft request' (duration: 168.990417ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:38:30.276983Z","caller":"traceutil/trace.go:171","msg":"trace[1797543213] transaction","detail":"{read_only:false; response_revision:4809; number_of_response:1; }","duration":"171.428642ms","start":"2026-09-29T15:38:30.105539Z","end":"2026-09-29T15:38:30.276968Z","steps":["trace[1797543213] 'process raft request' (duration: 171.27537ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:38:30.277245Z","caller":"traceutil/trace.go:171","msg":"trace[286924879] transaction","detail":"{read_only:false; response_revision:4810; number_of_response:1; }","duration":"130.604951ms","start":"2026-09-29T15:38:30.14663Z","end":"2026-09-29T15:38:30.277235Z","steps":["trace[286924879] 'process raft request' (duration: 130.288477ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:38:30.277296Z","caller":"traceutil/trace.go:171","msg":"trace[677541321] linearizableReadLoop","detail":"{readStateIndex:4997; appliedIndex:4995; }","duration":"164.453562ms","start":"2026-09-29T15:38:30.112827Z","end":"2026-09-29T15:38:30.277281Z","steps":["trace[677541321] 'read index received' (duration: 156.228563ms)","trace[677541321] 'applied index is now lower than readState.Index' (duration: 8.223709ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:38:30.27758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.665997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1223"} {"level":"info","ts":"2026-09-29T15:38:30.277618Z","caller":"traceutil/trace.go:171","msg":"trace[1321618068] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4812; }","duration":"160.734107ms","start":"2026-09-29T15:38:30.116868Z","end":"2026-09-29T15:38:30.277602Z","steps":["trace[1321618068] 'agreement among raft nodes before linearized reading' (duration: 160.573965ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:38:30.277779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.409208ms","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":"info","ts":"2026-09-29T15:38:30.278841Z","caller":"traceutil/trace.go:171","msg":"trace[533344400] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4812; }","duration":"133.498853ms","start":"2026-09-29T15:38:30.145321Z","end":"2026-09-29T15:38:30.27882Z","steps":["trace[533344400] 'agreement among raft nodes before linearized reading' (duration: 132.330936ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:38:30.279089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.304709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-29T15:38:30.279183Z","caller":"traceutil/trace.go:171","msg":"trace[1126950714] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4812; }","duration":"166.41804ms","start":"2026-09-29T15:38:30.112744Z","end":"2026-09-29T15:38:30.279162Z","steps":["trace[1126950714] 'agreement among raft nodes before linearized reading' (duration: 164.660965ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:38:34.584337Z","caller":"traceutil/trace.go:171","msg":"trace[1195489251] transaction","detail":"{read_only:false; response_revision:4954; number_of_response:1; }","duration":"123.347381ms","start":"2026-09-29T15:38:34.460966Z","end":"2026-09-29T15:38:34.584313Z","steps":["trace[1195489251] 'process raft request' (duration: 123.184809ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:38:34.629118Z","caller":"traceutil/trace.go:171","msg":"trace[217719506] transaction","detail":"{read_only:false; response_revision:4955; number_of_response:1; }","duration":"163.45852ms","start":"2026-09-29T15:38:34.465635Z","end":"2026-09-29T15:38:34.629094Z","steps":["trace[217719506] 'process raft request' (duration: 163.224697ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:38:34.629294Z","caller":"traceutil/trace.go:171","msg":"trace[1622898806] transaction","detail":"{read_only:false; response_revision:4956; number_of_response:1; }","duration":"142.996255ms","start":"2026-09-29T15:38:34.486282Z","end":"2026-09-29T15:38:34.629278Z","steps":["trace[1622898806] 'process raft request' (duration: 142.727821ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:38:34.630024Z","caller":"traceutil/trace.go:171","msg":"trace[1024682260] transaction","detail":"{read_only:false; response_revision:4957; number_of_response:1; }","duration":"115.790092ms","start":"2026-09-29T15:38:34.514216Z","end":"2026-09-29T15:38:34.630006Z","steps":["trace[1024682260] 'process raft request' (duration: 115.009951ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:38:39.691566Z","caller":"traceutil/trace.go:171","msg":"trace[1983567331] transaction","detail":"{read_only:false; response_revision:5061; number_of_response:1; }","duration":"128.671551ms","start":"2026-09-29T15:38:39.562849Z","end":"2026-09-29T15:38:39.691521Z","steps":["trace[1983567331] 'process raft request' (duration: 126.106265ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:38:51.182811Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2846} {"level":"info","ts":"2026-09-29T15:38:51.283965Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2846,"took":"99.248707ms","hash":2003660333,"current-db-size-bytes":52428800,"current-db-size":"52 MB","current-db-size-in-use-bytes":27287552,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-29T15:38:51.284055Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2003660333,"revision":2846,"compact-revision":-1} {"level":"info","ts":"2026-09-29T15:39:15.910916Z","caller":"traceutil/trace.go:171","msg":"trace[1392535962] transaction","detail":"{read_only:false; response_revision:5421; number_of_response:1; }","duration":"210.693179ms","start":"2026-09-29T15:39:15.700193Z","end":"2026-09-29T15:39:15.910886Z","steps":["trace[1392535962] 'process raft request' (duration: 210.377384ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:39:16.070309Z","caller":"traceutil/trace.go:171","msg":"trace[1538827993] transaction","detail":"{read_only:false; response_revision:5422; number_of_response:1; }","duration":"173.355012ms","start":"2026-09-29T15:39:15.89688Z","end":"2026-09-29T15:39:16.070235Z","steps":["trace[1538827993] 'process raft request' (duration: 157.062823ms)","trace[1538827993] 'compare' (duration: 15.273375ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:43:51.19345Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5170} {"level":"info","ts":"2026-09-29T15:43:51.28388Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5170,"took":"88.266971ms","hash":420507585,"current-db-size-bytes":52428800,"current-db-size":"52 MB","current-db-size-in-use-bytes":19316736,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-29T15:43:51.283979Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":420507585,"revision":5170,"compact-revision":2846} {"level":"info","ts":"2026-09-29T15:48:51.205319Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7366} {"level":"info","ts":"2026-09-29T15:48:51.275338Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7366,"took":"68.38221ms","hash":87064281,"current-db-size-bytes":52428800,"current-db-size":"52 MB","current-db-size-in-use-bytes":16273408,"current-db-size-in-use":"16 MB"} {"level":"info","ts":"2026-09-29T15:48:51.275407Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":87064281,"revision":7366,"compact-revision":5170}