{"level":"warn","ts":"2026-04-06T17:05:33.96378Z","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:05:33.9639Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.204: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.204:2380","--initial-cluster=instance=https://162.253.55.204:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.204:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.204: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:05:33.963987Z","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:05:33.964003Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.204:2380"]} {"level":"info","ts":"2026-04-06T17:05:33.964026Z","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:05:33.964864Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"]} {"level":"info","ts":"2026-04-06T17:05:33.964964Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.204: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:05:33.968914Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.660162ms"} {"level":"info","ts":"2026-04-06T17:05:33.975Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a11c20306510c1f7","cluster-id":"97da89d0cbebd2b5"} {"level":"info","ts":"2026-04-06T17:05:33.975148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=()"} {"level":"info","ts":"2026-04-06T17:05:33.975189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 0"} {"level":"info","ts":"2026-04-06T17:05:33.975221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a11c20306510c1f7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-06T17:05:33.97524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 1"} {"level":"info","ts":"2026-04-06T17:05:33.975308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"} {"level":"warn","ts":"2026-04-06T17:05:33.982181Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-06T17:05:33.983713Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-06T17:05:33.985006Z","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:05:33.987164Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a11c20306510c1f7","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-06T17:05:33.987554Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a11c20306510c1f7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-06T17:05:33.988544Z","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:05:33.989469Z","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:05:33.989664Z","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:05:33.989794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"} {"level":"info","ts":"2026-04-06T17:05:33.991087Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","added-peer-id":"a11c20306510c1f7","added-peer-peer-urls":["https://162.253.55.204:2380"]} {"level":"info","ts":"2026-04-06T17:05:33.993186Z","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:05:33.993252Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.204:2380"} {"level":"info","ts":"2026-04-06T17:05:33.993285Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.204:2380"} {"level":"info","ts":"2026-04-06T17:05:33.99363Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a11c20306510c1f7","initial-advertise-peer-urls":["https://162.253.55.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-06T17:05:33.993694Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-06T17:05:34.975904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 is starting a new election at term 1"} {"level":"info","ts":"2026-04-06T17:05:34.976109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-06T17:05:34.976202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgPreVoteResp from a11c20306510c1f7 at term 1"} {"level":"info","ts":"2026-04-06T17:05:34.976268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became candidate at term 2"} {"level":"info","ts":"2026-04-06T17:05:34.976307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgVoteResp from a11c20306510c1f7 at term 2"} {"level":"info","ts":"2026-04-06T17:05:34.976357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became leader at term 2"} {"level":"info","ts":"2026-04-06T17:05:34.976415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a11c20306510c1f7 elected leader a11c20306510c1f7 at term 2"} {"level":"info","ts":"2026-04-06T17:05:34.97791Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a11c20306510c1f7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.204:2379]}","request-path":"/0/members/a11c20306510c1f7/attributes","cluster-id":"97da89d0cbebd2b5","publish-timeout":"7s"} {"level":"info","ts":"2026-04-06T17:05:34.977964Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-06T17:05:34.977972Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T17:05:34.977916Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-06T17:05:34.978356Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-06T17:05:34.978418Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-06T17:05:34.979044Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T17:05:34.979165Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T17:05:34.979209Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T17:05:34.981441Z","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:05:34.983075Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.204:2379"} {"level":"warn","ts":"2026-04-06T17:05:55.107821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.101366ms","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-04-06T17:05:55.107932Z","caller":"traceutil/trace.go:171","msg":"trace[184028018] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:411; }","duration":"158.266421ms","start":"2026-04-06T17:05:54.949645Z","end":"2026-04-06T17:05:55.107912Z","steps":["trace[184028018] 'range keys from in-memory index tree' (duration: 157.975813ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:06:03.843957Z","caller":"traceutil/trace.go:171","msg":"trace[883955565] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"100.203619ms","start":"2026-04-06T17:06:03.743713Z","end":"2026-04-06T17:06:03.843916Z","steps":["trace[883955565] 'process raft request' (duration: 99.781977ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:06:03.847505Z","caller":"traceutil/trace.go:171","msg":"trace[1584125515] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"108.370367ms","start":"2026-04-06T17:06:03.735018Z","end":"2026-04-06T17:06:03.843388Z","steps":["trace[1584125515] 'process raft request' (duration: 93.7742ms)","trace[1584125515] 'compare' (duration: 14.389152ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:06:09.953012Z","caller":"traceutil/trace.go:171","msg":"trace[1495721664] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"133.708614ms","start":"2026-04-06T17:06:09.81927Z","end":"2026-04-06T17:06:09.952979Z","steps":["trace[1495721664] 'process raft request' (duration: 133.497179ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:06:09.985605Z","caller":"traceutil/trace.go:171","msg":"trace[708320376] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"133.056366ms","start":"2026-04-06T17:06:09.852521Z","end":"2026-04-06T17:06:09.985577Z","steps":["trace[708320376] 'process raft request' (duration: 132.944463ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:06:10.451476Z","caller":"traceutil/trace.go:171","msg":"trace[1310207106] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"161.894523ms","start":"2026-04-06T17:06:10.289541Z","end":"2026-04-06T17:06:10.451435Z","steps":["trace[1310207106] 'process raft request' (duration: 153.826587ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:06:12.092382Z","caller":"traceutil/trace.go:171","msg":"trace[964372188] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"100.296822ms","start":"2026-04-06T17:06:11.992058Z","end":"2026-04-06T17:06:12.092355Z","steps":["trace[964372188] 'process raft request' (duration: 100.189969ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:06:26.148704Z","caller":"traceutil/trace.go:171","msg":"trace[1193237585] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"116.391857ms","start":"2026-04-06T17:06:26.032284Z","end":"2026-04-06T17:06:26.148675Z","steps":["trace[1193237585] 'process raft request' (duration: 116.257453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:07:51.333906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.123347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-06T17:07:51.334031Z","caller":"traceutil/trace.go:171","msg":"trace[704926374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1899; }","duration":"112.317073ms","start":"2026-04-06T17:07:51.221691Z","end":"2026-04-06T17:07:51.334008Z","steps":["trace[704926374] 'range keys from in-memory index tree' (duration: 111.87675ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:08:22.128389Z","caller":"traceutil/trace.go:171","msg":"trace[2100586148] linearizableReadLoop","detail":"{readStateIndex:2156; appliedIndex:2155; }","duration":"151.570579ms","start":"2026-04-06T17:08:21.976784Z","end":"2026-04-06T17:08:22.128355Z","steps":["trace[2100586148] 'read index received' (duration: 113.129392ms)","trace[2100586148] 'applied index is now lower than readState.Index' (duration: 38.440117ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:08:22.128429Z","caller":"traceutil/trace.go:171","msg":"trace[744176812] transaction","detail":"{read_only:false; response_revision:2083; number_of_response:1; }","duration":"156.546163ms","start":"2026-04-06T17:08:21.971839Z","end":"2026-04-06T17:08:22.128385Z","steps":["trace[744176812] 'process raft request' (duration: 118.164797ms)","trace[744176812] 'compare' (duration: 38.16401ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:08:22.128696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.855407ms","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:22.128745Z","caller":"traceutil/trace.go:171","msg":"trace[1229904497] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2083; }","duration":"151.955799ms","start":"2026-04-06T17:08:21.976775Z","end":"2026-04-06T17:08:22.128731Z","steps":["trace[1229904497] 'agreement among raft nodes before linearized reading' (duration: 151.746294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:08:22.128743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.470925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a3d38e7a52df5c\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-04-06T17:08:22.128844Z","caller":"traceutil/trace.go:171","msg":"trace[2088157972] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18a3d38e7a52df5c; range_end:; response_count:1; response_revision:2083; }","duration":"125.619869ms","start":"2026-04-06T17:08:22.003204Z","end":"2026-04-06T17:08:22.128824Z","steps":["trace[2088157972] 'agreement among raft nodes before linearized reading' (duration: 125.360182ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:08:28.095738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.840104ms","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:28.095836Z","caller":"traceutil/trace.go:171","msg":"trace[2009611875] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2111; }","duration":"278.998468ms","start":"2026-04-06T17:08:27.816815Z","end":"2026-04-06T17:08:28.095813Z","steps":["trace[2009611875] 'range keys from in-memory index tree' (duration: 278.666059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:08:28.096543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.411998ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-06T17:08:28.096675Z","caller":"traceutil/trace.go:171","msg":"trace[1472133492] linearizableReadLoop","detail":"{readStateIndex:2186; appliedIndex:2185; }","duration":"123.620885ms","start":"2026-04-06T17:08:27.973024Z","end":"2026-04-06T17:08:28.096645Z","steps":["trace[1472133492] 'read index received' (duration: 51.572µs)","trace[1472133492] 'applied index is now lower than readState.Index' (duration: 123.568043ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:08:28.09675Z","caller":"traceutil/trace.go:171","msg":"trace[1506814531] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"231.927557ms","start":"2026-04-06T17:08:27.864776Z","end":"2026-04-06T17:08:28.096703Z","steps":["trace[1506814531] 'process raft request' (duration: 48.614124ms)","trace[1506814531] 'compare' (duration: 182.016007ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:08:28.097171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.12952ms","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-04-06T17:08:28.097284Z","caller":"traceutil/trace.go:171","msg":"trace[1387635573] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2112; }","duration":"124.295496ms","start":"2026-04-06T17:08:27.972962Z","end":"2026-04-06T17:08:28.097258Z","steps":["trace[1387635573] 'agreement among raft nodes before linearized reading' (duration: 123.751309ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:08:28.362072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.455238ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-04-06T17:08:28.362398Z","caller":"traceutil/trace.go:171","msg":"trace[1188991270] linearizableReadLoop","detail":"{readStateIndex:2189; appliedIndex:2186; }","duration":"164.361977ms","start":"2026-04-06T17:08:28.198012Z","end":"2026-04-06T17:08:28.362374Z","steps":["trace[1188991270] 'read index received' (duration: 50.603081ms)","trace[1188991270] 'applied index is now lower than readState.Index' (duration: 113.757696ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:08:28.362655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.626665ms","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:08:28.362718Z","caller":"traceutil/trace.go:171","msg":"trace[1588121558] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2114; }","duration":"164.736468ms","start":"2026-04-06T17:08:28.197964Z","end":"2026-04-06T17:08:28.362701Z","steps":["trace[1588121558] 'agreement among raft nodes before linearized reading' (duration: 164.490911ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:08:28.362902Z","caller":"traceutil/trace.go:171","msg":"trace[185385623] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"261.958137ms","start":"2026-04-06T17:08:28.100929Z","end":"2026-04-06T17:08:28.362887Z","steps":["trace[185385623] 'process raft request' (duration: 261.267828ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:08:28.363029Z","caller":"traceutil/trace.go:171","msg":"trace[1905996410] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"215.71582ms","start":"2026-04-06T17:08:28.1473Z","end":"2026-04-06T17:08:28.363016Z","steps":["trace[1905996410] 'process raft request' (duration: 215.023389ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:34.146599Z","caller":"traceutil/trace.go:171","msg":"trace[931420705] linearizableReadLoop","detail":"{readStateIndex:4765; appliedIndex:4763; }","duration":"119.661468ms","start":"2026-04-06T17:13:34.026909Z","end":"2026-04-06T17:13:34.14657Z","steps":["trace[931420705] 'read index received' (duration: 48.39685ms)","trace[931420705] 'applied index is now lower than readState.Index' (duration: 71.263378ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:13:34.14663Z","caller":"traceutil/trace.go:171","msg":"trace[332022321] transaction","detail":"{read_only:false; response_revision:4592; number_of_response:1; }","duration":"119.759151ms","start":"2026-04-06T17:13:34.026839Z","end":"2026-04-06T17:13:34.146598Z","steps":["trace[332022321] 'process raft request' (duration: 119.529494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:13:34.146914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.916045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T17:13:34.146952Z","caller":"traceutil/trace.go:171","msg":"trace[63279098] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:4593; }","duration":"120.1024ms","start":"2026-04-06T17:13:34.026839Z","end":"2026-04-06T17:13:34.146941Z","steps":["trace[63279098] 'agreement among raft nodes before linearized reading' (duration: 119.879724ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:34.146945Z","caller":"traceutil/trace.go:171","msg":"trace[1016072150] transaction","detail":"{read_only:false; response_revision:4593; number_of_response:1; }","duration":"118.903887ms","start":"2026-04-06T17:13:34.0278Z","end":"2026-04-06T17:13:34.146704Z","steps":["trace[1016072150] 'process raft request' (duration: 118.702741ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:39.423858Z","caller":"traceutil/trace.go:171","msg":"trace[1771128702] linearizableReadLoop","detail":"{readStateIndex:4935; appliedIndex:4934; }","duration":"104.53464ms","start":"2026-04-06T17:13:39.3193Z","end":"2026-04-06T17:13:39.423834Z","steps":["trace[1771128702] 'read index received' (duration: 104.393456ms)","trace[1771128702] 'applied index is now lower than readState.Index' (duration: 139.564µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:13:39.423964Z","caller":"traceutil/trace.go:171","msg":"trace[1409337651] transaction","detail":"{read_only:false; response_revision:4757; number_of_response:1; }","duration":"109.716817ms","start":"2026-04-06T17:13:39.314191Z","end":"2026-04-06T17:13:39.423907Z","steps":["trace[1409337651] 'process raft request' (duration: 109.496771ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:13:39.424141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.579825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-06T17:13:39.424217Z","caller":"traceutil/trace.go:171","msg":"trace[774190704] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4757; }","duration":"113.72099ms","start":"2026-04-06T17:13:39.310479Z","end":"2026-04-06T17:13:39.4242Z","steps":["trace[774190704] 'agreement among raft nodes before linearized reading' (duration: 113.492004ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:13:54.54751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.127909ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-06T17:13:54.547624Z","caller":"traceutil/trace.go:171","msg":"trace[644476043] linearizableReadLoop","detail":"{readStateIndex:5316; appliedIndex:5315; }","duration":"274.524268ms","start":"2026-04-06T17:13:54.273082Z","end":"2026-04-06T17:13:54.547606Z","steps":["trace[644476043] 'read index received' (duration: 171.196014ms)","trace[644476043] 'applied index is now lower than readState.Index' (duration: 103.327044ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:13:54.547773Z","caller":"traceutil/trace.go:171","msg":"trace[1490922061] transaction","detail":"{read_only:false; response_revision:5127; number_of_response:1; }","duration":"306.640306ms","start":"2026-04-06T17:13:54.241112Z","end":"2026-04-06T17:13:54.547752Z","steps":["trace[1490922061] 'process raft request' (duration: 203.179078ms)","trace[1490922061] 'compare' (duration: 102.843131ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:13:54.54788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:13:54.241082Z","time spent":"306.747769ms","remote":"127.0.0.1:46636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8038,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-06T17:13:54.548058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.887178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:17453"} {"level":"info","ts":"2026-04-06T17:13:54.548154Z","caller":"traceutil/trace.go:171","msg":"trace[213461318] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5127; }","duration":"275.059403ms","start":"2026-04-06T17:13:54.273074Z","end":"2026-04-06T17:13:54.548133Z","steps":["trace[213461318] 'agreement among raft nodes before linearized reading' (duration: 274.741174ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:54.603301Z","caller":"traceutil/trace.go:171","msg":"trace[1354515066] transaction","detail":"{read_only:false; response_revision:5129; number_of_response:1; }","duration":"326.482058ms","start":"2026-04-06T17:13:54.276797Z","end":"2026-04-06T17:13:54.603279Z","steps":["trace[1354515066] 'process raft request' (duration: 326.438866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:13:54.603423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:13:54.276789Z","time spent":"326.57938ms","remote":"127.0.0.1:46710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1005,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-06T17:13:54.603581Z","caller":"traceutil/trace.go:171","msg":"trace[610870062] transaction","detail":"{read_only:false; response_revision:5128; number_of_response:1; }","duration":"327.539838ms","start":"2026-04-06T17:13:54.27577Z","end":"2026-04-06T17:13:54.60331Z","steps":["trace[610870062] 'process raft request' (duration: 327.361123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:13:54.603805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:13:54.275753Z","time spent":"327.9607ms","remote":"127.0.0.1:46612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":524,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-06T17:13:54.761Z","caller":"traceutil/trace.go:171","msg":"trace[1484893682] transaction","detail":"{read_only:false; response_revision:5130; number_of_response:1; }","duration":"285.940661ms","start":"2026-04-06T17:13:54.47502Z","end":"2026-04-06T17:13:54.76096Z","steps":["trace[1484893682] 'process raft request' (duration: 214.744497ms)","trace[1484893682] 'compare' (duration: 70.901136ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:13:54.76101Z","caller":"traceutil/trace.go:171","msg":"trace[1831340115] transaction","detail":"{read_only:false; response_revision:5131; number_of_response:1; }","duration":"207.956184ms","start":"2026-04-06T17:13:54.553023Z","end":"2026-04-06T17:13:54.76098Z","steps":["trace[1831340115] 'process raft request' (duration: 207.799569ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:54.761251Z","caller":"traceutil/trace.go:171","msg":"trace[989247491] transaction","detail":"{read_only:false; response_revision:5132; number_of_response:1; }","duration":"207.359967ms","start":"2026-04-06T17:13:54.553822Z","end":"2026-04-06T17:13:54.761182Z","steps":["trace[989247491] 'process raft request' (duration: 207.09968ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:54.761313Z","caller":"traceutil/trace.go:171","msg":"trace[1062177338] linearizableReadLoop","detail":"{readStateIndex:5319; appliedIndex:5316; }","duration":"213.640977ms","start":"2026-04-06T17:13:54.547651Z","end":"2026-04-06T17:13:54.761292Z","steps":["trace[1062177338] 'read index received' (duration: 55.557553ms)","trace[1062177338] 'applied index is now lower than readState.Index' (duration: 158.081994ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:13:54.76139Z","caller":"traceutil/trace.go:171","msg":"trace[78353616] transaction","detail":"{read_only:false; response_revision:5133; number_of_response:1; }","duration":"152.826905ms","start":"2026-04-06T17:13:54.608542Z","end":"2026-04-06T17:13:54.761369Z","steps":["trace[78353616] 'process raft request' (duration: 152.641239ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:54.761385Z","caller":"traceutil/trace.go:171","msg":"trace[1064023971] transaction","detail":"{read_only:false; response_revision:5134; number_of_response:1; }","duration":"152.580778ms","start":"2026-04-06T17:13:54.608777Z","end":"2026-04-06T17:13:54.761358Z","steps":["trace[1064023971] 'process raft request' (duration: 152.518997ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:13:54.761502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.564881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T17:13:54.761488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.039137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T17:13:54.761556Z","caller":"traceutil/trace.go:171","msg":"trace[1384017663] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5134; }","duration":"150.713985ms","start":"2026-04-06T17:13:54.610831Z","end":"2026-04-06T17:13:54.761545Z","steps":["trace[1384017663] 'agreement among raft nodes before linearized reading' (duration: 150.622162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:13:54.761593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.710601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-m25bj\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-06T17:13:54.761581Z","caller":"traceutil/trace.go:171","msg":"trace[1367693742] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:5134; }","duration":"237.179212ms","start":"2026-04-06T17:13:54.524383Z","end":"2026-04-06T17:13:54.761563Z","steps":["trace[1367693742] 'agreement among raft nodes before linearized reading' (duration: 237.015838ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:54.761612Z","caller":"traceutil/trace.go:171","msg":"trace[1871076979] range","detail":"{range_begin:/registry/pods/openstack/keepalived-m25bj; range_end:; response_count:1; response_revision:5134; }","duration":"129.772313ms","start":"2026-04-06T17:13:54.631834Z","end":"2026-04-06T17:13:54.761606Z","steps":["trace[1871076979] 'agreement among raft nodes before linearized reading' (duration: 129.696331ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:13:54.761608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.530243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-04-06T17:13:54.761636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.331872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-06T17:13:54.761654Z","caller":"traceutil/trace.go:171","msg":"trace[903795379] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5134; }","duration":"207.618955ms","start":"2026-04-06T17:13:54.554022Z","end":"2026-04-06T17:13:54.761641Z","steps":["trace[903795379] 'agreement among raft nodes before linearized reading' (duration: 207.401379ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:13:54.76169Z","caller":"traceutil/trace.go:171","msg":"trace[610532248] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:5134; }","duration":"169.445195ms","start":"2026-04-06T17:13:54.592229Z","end":"2026-04-06T17:13:54.761674Z","steps":["trace[610532248] 'agreement among raft nodes before linearized reading' (duration: 169.350453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:13:54.761902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.139305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T17:13:54.761947Z","caller":"traceutil/trace.go:171","msg":"trace[1066109529] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:5134; }","duration":"187.239329ms","start":"2026-04-06T17:13:54.574697Z","end":"2026-04-06T17:13:54.761936Z","steps":["trace[1066109529] 'agreement among raft nodes before linearized reading' (duration: 187.147556ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:14:02.549808Z","caller":"traceutil/trace.go:171","msg":"trace[1728940491] transaction","detail":"{read_only:false; response_revision:5292; number_of_response:1; }","duration":"142.859643ms","start":"2026-04-06T17:14:02.406909Z","end":"2026-04-06T17:14:02.549768Z","steps":["trace[1728940491] 'process raft request' (duration: 129.305399ms)","trace[1728940491] 'compare' (duration: 13.345138ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:14:02.795305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.65027ms","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-04-06T17:14:02.79562Z","caller":"traceutil/trace.go:171","msg":"trace[500328981] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5292; }","duration":"123.167045ms","start":"2026-04-06T17:14:02.672419Z","end":"2026-04-06T17:14:02.795586Z","steps":["trace[500328981] 'range keys from in-memory index tree' (duration: 122.616529ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:15:35.006208Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3000} {"level":"info","ts":"2026-04-06T17:15:35.09051Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3000,"took":"81.109729ms","hash":1270593882,"current-db-size-bytes":58720256,"current-db-size":"59 MB","current-db-size-in-use-bytes":34025472,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-06T17:15:35.090594Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1270593882,"revision":3000,"compact-revision":-1} {"level":"info","ts":"2026-04-06T17:20:08.527832Z","caller":"traceutil/trace.go:171","msg":"trace[1493806684] transaction","detail":"{read_only:false; response_revision:8137; number_of_response:1; }","duration":"286.806944ms","start":"2026-04-06T17:20:08.240997Z","end":"2026-04-06T17:20:08.527804Z","steps":["trace[1493806684] 'process raft request' (duration: 286.633759ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:20:20.413284Z","caller":"traceutil/trace.go:171","msg":"trace[1141823790] linearizableReadLoop","detail":"{readStateIndex:8482; appliedIndex:8481; }","duration":"238.455978ms","start":"2026-04-06T17:20:20.174806Z","end":"2026-04-06T17:20:20.413262Z","steps":["trace[1141823790] 'read index received' (duration: 238.278403ms)","trace[1141823790] 'applied index is now lower than readState.Index' (duration: 176.504µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:20:20.413322Z","caller":"traceutil/trace.go:171","msg":"trace[324602729] transaction","detail":"{read_only:false; response_revision:8201; number_of_response:1; }","duration":"239.845507ms","start":"2026-04-06T17:20:20.173442Z","end":"2026-04-06T17:20:20.413287Z","steps":["trace[324602729] 'process raft request' (duration: 239.666052ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:20:20.413497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.674134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T17:20:20.413585Z","caller":"traceutil/trace.go:171","msg":"trace[1730822733] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:8201; }","duration":"238.844559ms","start":"2026-04-06T17:20:20.174723Z","end":"2026-04-06T17:20:20.413568Z","steps":["trace[1730822733] 'agreement among raft nodes before linearized reading' (duration: 238.637013ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:20:35.013501Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6108} {"level":"info","ts":"2026-04-06T17:20:35.112081Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6108,"took":"96.210462ms","hash":1319259286,"current-db-size-bytes":58720256,"current-db-size":"59 MB","current-db-size-in-use-bytes":22958080,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-06T17:20:35.112152Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1319259286,"revision":6108,"compact-revision":3000} {"level":"info","ts":"2026-04-06T17:20:48.150696Z","caller":"traceutil/trace.go:171","msg":"trace[1943761772] transaction","detail":"{read_only:false; response_revision:8401; number_of_response:1; }","duration":"392.347952ms","start":"2026-04-06T17:20:47.758313Z","end":"2026-04-06T17:20:48.150661Z","steps":["trace[1943761772] 'process raft request' (duration: 392.129856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:20:48.150942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:20:47.758277Z","time spent":"392.531218ms","remote":"127.0.0.1:46708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T17:20:48.166559Z","caller":"traceutil/trace.go:171","msg":"trace[785485651] linearizableReadLoop","detail":"{readStateIndex:8691; appliedIndex:8689; }","duration":"405.494185ms","start":"2026-04-06T17:20:47.761042Z","end":"2026-04-06T17:20:48.166537Z","steps":["trace[785485651] 'read index received' (duration: 389.507192ms)","trace[785485651] 'applied index is now lower than readState.Index' (duration: 15.986153ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T17:20:48.166621Z","caller":"traceutil/trace.go:171","msg":"trace[598031054] transaction","detail":"{read_only:false; response_revision:8402; number_of_response:1; }","duration":"407.424068ms","start":"2026-04-06T17:20:47.759156Z","end":"2026-04-06T17:20:48.16658Z","steps":["trace[598031054] 'process raft request' (duration: 406.785331ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:20:48.166723Z","caller":"traceutil/trace.go:171","msg":"trace[1167736943] transaction","detail":"{read_only:false; response_revision:8403; number_of_response:1; }","duration":"292.445475ms","start":"2026-04-06T17:20:47.87416Z","end":"2026-04-06T17:20:48.166605Z","steps":["trace[1167736943] 'process raft request' (duration: 292.332812ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:20:48.16681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.745012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-06T17:20:48.166872Z","caller":"traceutil/trace.go:171","msg":"trace[464012677] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8403; }","duration":"405.819515ms","start":"2026-04-06T17:20:47.761017Z","end":"2026-04-06T17:20:48.166836Z","steps":["trace[464012677] 'agreement among raft nodes before linearized reading' (duration: 405.63964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:20:48.166902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:20:47.76101Z","time spent":"405.885636ms","remote":"127.0.0.1:46708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-06T17:20:48.166773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:20:47.759125Z","time spent":"407.571283ms","remote":"127.0.0.1:46708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-06T17:20:48.167081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.15071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-06T17:20:48.167177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.315083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-04-06T17:20:48.167227Z","caller":"traceutil/trace.go:171","msg":"trace[1495708666] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8403; }","duration":"350.360974ms","start":"2026-04-06T17:20:47.81685Z","end":"2026-04-06T17:20:48.167211Z","steps":["trace[1495708666] 'agreement among raft nodes before linearized reading' (duration: 350.145078ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:20:48.167268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:20:47.816772Z","time spent":"350.484018ms","remote":"127.0.0.1:46636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-04-06T17:20:48.167178Z","caller":"traceutil/trace.go:171","msg":"trace[364477573] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8403; }","duration":"120.334936ms","start":"2026-04-06T17:20:48.046826Z","end":"2026-04-06T17:20:48.167161Z","steps":["trace[364477573] 'agreement among raft nodes before linearized reading' (duration: 120.200812ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:20:48.167104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.945643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T17:20:48.167456Z","caller":"traceutil/trace.go:171","msg":"trace[872430902] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8403; }","duration":"350.317423ms","start":"2026-04-06T17:20:47.817102Z","end":"2026-04-06T17:20:48.16742Z","steps":["trace[872430902] 'agreement among raft nodes before linearized reading' (duration: 349.927512ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:20:48.167522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:20:47.817094Z","time spent":"350.411416ms","remote":"127.0.0.1:46462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-06T17:20:50.996092Z","caller":"traceutil/trace.go:171","msg":"trace[99907210] transaction","detail":"{read_only:false; response_revision:8418; number_of_response:1; }","duration":"373.612863ms","start":"2026-04-06T17:20:50.622448Z","end":"2026-04-06T17:20:50.996061Z","steps":["trace[99907210] 'process raft request' (duration: 373.377566ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T17:20:50.996363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T17:20:50.622428Z","time spent":"373.743566ms","remote":"127.0.0.1:46708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T17:20:51.002425Z","caller":"traceutil/trace.go:171","msg":"trace[1630522766] linearizableReadLoop","detail":"{readStateIndex:8709; appliedIndex:8707; }","duration":"185.308264ms","start":"2026-04-06T17:20:50.817096Z","end":"2026-04-06T17:20:51.002404Z","steps":["trace[1630522766] 'read index received' (duration: 178.750739ms)","trace[1630522766] 'applied index is now lower than readState.Index' (duration: 6.555335ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T17:20:51.002545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.441847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T17:20:51.002588Z","caller":"traceutil/trace.go:171","msg":"trace[818827101] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8419; }","duration":"185.549891ms","start":"2026-04-06T17:20:50.817024Z","end":"2026-04-06T17:20:51.002574Z","steps":["trace[818827101] 'agreement among raft nodes before linearized reading' (duration: 185.449268ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:20:51.002793Z","caller":"traceutil/trace.go:171","msg":"trace[1840150683] transaction","detail":"{read_only:false; response_revision:8419; number_of_response:1; }","duration":"245.61574ms","start":"2026-04-06T17:20:50.756904Z","end":"2026-04-06T17:20:51.00252Z","steps":["trace[1840150683] 'process raft request' (duration: 245.405654ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:21:01.249311Z","caller":"traceutil/trace.go:171","msg":"trace[1511585505] transaction","detail":"{read_only:false; response_revision:8514; number_of_response:1; }","duration":"190.300736ms","start":"2026-04-06T17:21:01.058798Z","end":"2026-04-06T17:21:01.249099Z","steps":["trace[1511585505] 'process raft request' (duration: 190.122851ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:21:01.284124Z","caller":"traceutil/trace.go:171","msg":"trace[1636849610] transaction","detail":"{read_only:false; response_revision:8515; number_of_response:1; }","duration":"207.562185ms","start":"2026-04-06T17:21:01.076547Z","end":"2026-04-06T17:21:01.284109Z","steps":["trace[1636849610] 'process raft request' (duration: 207.422291ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:21:01.284374Z","caller":"traceutil/trace.go:171","msg":"trace[524473060] transaction","detail":"{read_only:false; response_revision:8516; number_of_response:1; }","duration":"205.163597ms","start":"2026-04-06T17:21:01.079189Z","end":"2026-04-06T17:21:01.284352Z","steps":["trace[524473060] 'process raft request' (duration: 204.879859ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:21:01.284538Z","caller":"traceutil/trace.go:171","msg":"trace[1965879163] transaction","detail":"{read_only:false; response_revision:8517; number_of_response:1; }","duration":"115.332514ms","start":"2026-04-06T17:21:01.16917Z","end":"2026-04-06T17:21:01.284503Z","steps":["trace[1965879163] 'process raft request' (duration: 115.093687ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:21:47.526228Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002413.wal"} {"level":"info","ts":"2026-04-06T17:22:04.842207Z","caller":"traceutil/trace.go:171","msg":"trace[1710098085] transaction","detail":"{read_only:false; response_revision:9191; number_of_response:1; }","duration":"117.69101ms","start":"2026-04-06T17:22:04.724471Z","end":"2026-04-06T17:22:04.842162Z","steps":["trace[1710098085] 'process raft request' (duration: 117.400772ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T17:23:13.589207Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a11c20306510c1f7","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-06T17:23:13.595283Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-06T17:23:13.595396Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-06T17:25:35.021201Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8283} {"level":"info","ts":"2026-04-06T17:25:35.101084Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8283,"took":"77.587417ms","hash":1098350067,"current-db-size-bytes":58720256,"current-db-size":"59 MB","current-db-size-in-use-bytes":24895488,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-06T17:25:35.101165Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1098350067,"revision":8283,"compact-revision":6108} {"level":"info","ts":"2026-04-06T17:30:35.026589Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10676} {"level":"info","ts":"2026-04-06T17:30:35.108879Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10676,"took":"79.630466ms","hash":3737638481,"current-db-size-bytes":58720256,"current-db-size":"59 MB","current-db-size-in-use-bytes":20389888,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-06T17:30:35.108943Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3737638481,"revision":10676,"compact-revision":8283}