{"level":"warn","ts":"2026-10-17T11:32:37.801168Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-17T11:32:37.801319Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.214: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.214:2380","--initial-cluster=instance=https://162.253.55.214:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.214:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.214: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-10-17T11:32:37.801389Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-17T11:32:37.801407Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.214:2380"]} {"level":"info","ts":"2026-10-17T11:32:37.801425Z","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-10-17T11:32:37.802182Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.214:2379"]} {"level":"info","ts":"2026-10-17T11:32:37.802271Z","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.214:2380"],"listen-peer-urls":["https://162.253.55.214:2380"],"advertise-client-urls":["https://162.253.55.214:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.214:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.214: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-10-17T11:32:37.806433Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.921937ms"} {"level":"info","ts":"2026-10-17T11:32:37.812614Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"86f12f2ae020828","cluster-id":"dfe59afaaa064e4a"} {"level":"info","ts":"2026-10-17T11:32:37.812721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 switched to configuration voters=()"} {"level":"info","ts":"2026-10-17T11:32:37.812742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became follower at term 0"} {"level":"info","ts":"2026-10-17T11:32:37.81276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 86f12f2ae020828 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-17T11:32:37.812769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became follower at term 1"} {"level":"info","ts":"2026-10-17T11:32:37.812806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 switched to configuration voters=(607725308229060648)"} {"level":"warn","ts":"2026-10-17T11:32:37.821426Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-17T11:32:37.823293Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-17T11:32:37.826298Z","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-10-17T11:32:37.831853Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"86f12f2ae020828","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-17T11:32:37.831981Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"86f12f2ae020828","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-17T11:32:37.832181Z","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-10-17T11:32:37.832252Z","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-10-17T11:32:37.832272Z","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-10-17T11:32:37.834118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 switched to configuration voters=(607725308229060648)"} {"level":"info","ts":"2026-10-17T11:32:37.834534Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfe59afaaa064e4a","local-member-id":"86f12f2ae020828","added-peer-id":"86f12f2ae020828","added-peer-peer-urls":["https://162.253.55.214:2380"]} {"level":"info","ts":"2026-10-17T11:32:37.837613Z","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-10-17T11:32:37.83779Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.214:2380"} {"level":"info","ts":"2026-10-17T11:32:37.837866Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.214:2380"} {"level":"info","ts":"2026-10-17T11:32:37.83813Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"86f12f2ae020828","initial-advertise-peer-urls":["https://162.253.55.214:2380"],"listen-peer-urls":["https://162.253.55.214:2380"],"advertise-client-urls":["https://162.253.55.214:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.214:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-17T11:32:37.838198Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-17T11:32:38.517133Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 is starting a new election at term 1"} {"level":"info","ts":"2026-10-17T11:32:38.517188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-17T11:32:38.517216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 received MsgPreVoteResp from 86f12f2ae020828 at term 1"} {"level":"info","ts":"2026-10-17T11:32:38.517229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became candidate at term 2"} {"level":"info","ts":"2026-10-17T11:32:38.517236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 received MsgVoteResp from 86f12f2ae020828 at term 2"} {"level":"info","ts":"2026-10-17T11:32:38.517246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became leader at term 2"} {"level":"info","ts":"2026-10-17T11:32:38.517254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 86f12f2ae020828 elected leader 86f12f2ae020828 at term 2"} {"level":"info","ts":"2026-10-17T11:32:38.518233Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T11:32:38.51924Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"86f12f2ae020828","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.214:2379]}","request-path":"/0/members/86f12f2ae020828/attributes","cluster-id":"dfe59afaaa064e4a","publish-timeout":"7s"} {"level":"info","ts":"2026-10-17T11:32:38.519413Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T11:32:38.519476Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T11:32:38.519668Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-17T11:32:38.519753Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-17T11:32:38.522555Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfe59afaaa064e4a","local-member-id":"86f12f2ae020828","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T11:32:38.522676Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T11:32:38.522704Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T11:32:38.523249Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.214:2379"} {"level":"info","ts":"2026-10-17T11:32:38.524254Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-10-17T11:32:57.034197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.763676ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-17T11:33:22.771954Z","caller":"traceutil/trace.go:171","msg":"trace[385859867] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"144.457256ms","start":"2026-10-17T11:33:22.627474Z","end":"2026-10-17T11:33:22.771931Z","steps":["trace[385859867] 'process raft request' (duration: 144.2545ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:30.162787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.501956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:33:30.162882Z","caller":"traceutil/trace.go:171","msg":"trace[1222860549] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:649; }","duration":"394.65285ms","start":"2026-10-17T11:33:29.768209Z","end":"2026-10-17T11:33:30.162862Z","steps":["trace[1222860549] 'range keys from in-memory index tree' (duration: 394.414083ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:33:30.162901Z","caller":"traceutil/trace.go:171","msg":"trace[1916174571] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:669; }","duration":"321.737039ms","start":"2026-10-17T11:33:29.841134Z","end":"2026-10-17T11:33:30.162871Z","steps":["trace[1916174571] 'read index received' (duration: 240.099699ms)","trace[1916174571] 'applied index is now lower than readState.Index' (duration: 81.63603ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:33:30.162921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:33:29.768186Z","time spent":"394.726642ms","remote":"127.0.0.1:50716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-17T11:33:30.163051Z","caller":"traceutil/trace.go:171","msg":"trace[229063858] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"391.311779ms","start":"2026-10-17T11:33:29.771723Z","end":"2026-10-17T11:33:30.163035Z","steps":["trace[229063858] 'process raft request' (duration: 309.655738ms)","trace[229063858] 'compare' (duration: 81.319871ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:33:30.163642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.007586ms","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-10-17T11:33:30.163727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.601783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mkp5l\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-17T11:33:30.163745Z","caller":"traceutil/trace.go:171","msg":"trace[767094740] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:650; }","duration":"281.14946ms","start":"2026-10-17T11:33:29.882566Z","end":"2026-10-17T11:33:30.163715Z","steps":["trace[767094740] 'agreement among raft nodes before linearized reading' (duration: 280.634566ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:30.163863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:33:29.771705Z","time spent":"391.385001ms","remote":"127.0.0.1:51040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-17T11:33:30.163768Z","caller":"traceutil/trace.go:171","msg":"trace[1938115635] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mkp5l; range_end:; response_count:1; response_revision:650; }","duration":"322.702525ms","start":"2026-10-17T11:33:29.841051Z","end":"2026-10-17T11:33:30.163754Z","steps":["trace[1938115635] 'agreement among raft nodes before linearized reading' (duration: 322.481399ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:30.164086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:33:29.841019Z","time spent":"323.053255ms","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-mkp5l\" "} {"level":"info","ts":"2026-10-17T11:34:14.976414Z","caller":"traceutil/trace.go:171","msg":"trace[571373355] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"162.55693ms","start":"2026-10-17T11:34:14.813832Z","end":"2026-10-17T11:34:14.976389Z","steps":["trace[571373355] 'process raft request' (duration: 162.399306ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:35:03.361427Z","caller":"traceutil/trace.go:171","msg":"trace[1122639705] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"137.031293ms","start":"2026-10-17T11:35:03.22437Z","end":"2026-10-17T11:35:03.361401Z","steps":["trace[1122639705] 'process raft request' (duration: 136.843038ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:35:03.470526Z","caller":"traceutil/trace.go:171","msg":"trace[1006205151] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"104.26002ms","start":"2026-10-17T11:35:03.366199Z","end":"2026-10-17T11:35:03.470459Z","steps":["trace[1006205151] 'process raft request' (duration: 52.770978ms)","trace[1006205151] 'compare' (duration: 51.330168ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:35:03.480408Z","caller":"traceutil/trace.go:171","msg":"trace[1900118486] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"114.120399ms","start":"2026-10-17T11:35:03.366258Z","end":"2026-10-17T11:35:03.480379Z","steps":["trace[1900118486] 'process raft request' (duration: 113.725998ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:35:03.48043Z","caller":"traceutil/trace.go:171","msg":"trace[214044175] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"109.811411ms","start":"2026-10-17T11:35:03.370587Z","end":"2026-10-17T11:35:03.480399Z","steps":["trace[214044175] 'process raft request' (duration: 109.535534ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:35:17.073318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.581539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-17T11:35:17.073414Z","caller":"traceutil/trace.go:171","msg":"trace[643284113] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:2004; }","duration":"151.734464ms","start":"2026-10-17T11:35:16.92166Z","end":"2026-10-17T11:35:17.073394Z","steps":["trace[643284113] 'count revisions from in-memory index tree' (duration: 151.495026ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:35:53.962163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.839965ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:35:53.962287Z","caller":"traceutil/trace.go:171","msg":"trace[1425869715] transaction","detail":"{read_only:false; response_revision:2213; number_of_response:1; }","duration":"219.918762ms","start":"2026-10-17T11:35:53.742338Z","end":"2026-10-17T11:35:53.962257Z","steps":["trace[1425869715] 'process raft request' (duration: 106.705996ms)","trace[1425869715] 'compare' (duration: 112.732813ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:35:53.978817Z","caller":"traceutil/trace.go:171","msg":"trace[430648144] linearizableReadLoop","detail":"{readStateIndex:2293; appliedIndex:2291; }","duration":"209.097835ms","start":"2026-10-17T11:35:53.769674Z","end":"2026-10-17T11:35:53.978772Z","steps":["trace[430648144] 'read index received' (duration: 79.387325ms)","trace[430648144] 'applied index is now lower than readState.Index' (duration: 129.70932ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:35:53.978922Z","caller":"traceutil/trace.go:171","msg":"trace[648026832] transaction","detail":"{read_only:false; response_revision:2215; number_of_response:1; }","duration":"169.884936ms","start":"2026-10-17T11:35:53.80901Z","end":"2026-10-17T11:35:53.978895Z","steps":["trace[648026832] 'process raft request' (duration: 169.705141ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:35:53.978869Z","caller":"traceutil/trace.go:171","msg":"trace[1635407505] transaction","detail":"{read_only:false; response_revision:2214; number_of_response:1; }","duration":"236.017495ms","start":"2026-10-17T11:35:53.742802Z","end":"2026-10-17T11:35:53.97882Z","steps":["trace[1635407505] 'process raft request' (duration: 235.653575ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:35:53.979078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.379402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:35:53.979127Z","caller":"traceutil/trace.go:171","msg":"trace[746693476] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2215; }","duration":"209.504656ms","start":"2026-10-17T11:35:53.769609Z","end":"2026-10-17T11:35:53.979113Z","steps":["trace[746693476] 'agreement among raft nodes before linearized reading' (duration: 209.364852ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:35:53.979274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.938209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-17T11:35:53.979418Z","caller":"traceutil/trace.go:171","msg":"trace[1396403827] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:2215; }","duration":"157.169205ms","start":"2026-10-17T11:35:53.822212Z","end":"2026-10-17T11:35:53.979381Z","steps":["trace[1396403827] 'agreement among raft nodes before linearized reading' (duration: 156.812306ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:35:59.214753Z","caller":"traceutil/trace.go:171","msg":"trace[725282870] transaction","detail":"{read_only:false; response_revision:2242; number_of_response:1; }","duration":"119.469728ms","start":"2026-10-17T11:35:59.095259Z","end":"2026-10-17T11:35:59.214729Z","steps":["trace[725282870] 'process raft request' (duration: 119.320893ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:36:47.695896Z","caller":"traceutil/trace.go:171","msg":"trace[1208545041] transaction","detail":"{read_only:false; response_revision:2673; number_of_response:1; }","duration":"209.393389ms","start":"2026-10-17T11:36:47.486478Z","end":"2026-10-17T11:36:47.695871Z","steps":["trace[1208545041] 'process raft request' (duration: 209.248315ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:37:20.510518Z","caller":"traceutil/trace.go:171","msg":"trace[398831358] linearizableReadLoop","detail":"{readStateIndex:2976; appliedIndex:2975; }","duration":"108.167314ms","start":"2026-10-17T11:37:20.402324Z","end":"2026-10-17T11:37:20.510491Z","steps":["trace[398831358] 'read index received' (duration: 107.955848ms)","trace[398831358] 'applied index is now lower than readState.Index' (duration: 210.306µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:37:20.510657Z","caller":"traceutil/trace.go:171","msg":"trace[674461987] transaction","detail":"{read_only:false; response_revision:2872; number_of_response:1; }","duration":"109.172662ms","start":"2026-10-17T11:37:20.401423Z","end":"2026-10-17T11:37:20.510595Z","steps":["trace[674461987] 'process raft request' (duration: 108.863293ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:37:20.511032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.684269ms","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-10-17T11:37:20.511085Z","caller":"traceutil/trace.go:171","msg":"trace[1428511233] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2872; }","duration":"108.793921ms","start":"2026-10-17T11:37:20.402276Z","end":"2026-10-17T11:37:20.51107Z","steps":["trace[1428511233] 'agreement among raft nodes before linearized reading' (duration: 108.320008ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:37:20.615448Z","caller":"traceutil/trace.go:171","msg":"trace[1037803013] transaction","detail":"{read_only:false; response_revision:2873; number_of_response:1; }","duration":"100.074264ms","start":"2026-10-17T11:37:20.515347Z","end":"2026-10-17T11:37:20.615422Z","steps":["trace[1037803013] 'process raft request' (duration: 72.322558ms)","trace[1037803013] 'compare' (duration: 27.482498ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:37:26.260198Z","caller":"traceutil/trace.go:171","msg":"trace[34703796] transaction","detail":"{read_only:false; response_revision:2905; number_of_response:1; }","duration":"121.122116ms","start":"2026-10-17T11:37:26.139046Z","end":"2026-10-17T11:37:26.260169Z","steps":["trace[34703796] 'process raft request' (duration: 120.935281ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:16.087832Z","caller":"traceutil/trace.go:171","msg":"trace[302567510] transaction","detail":"{read_only:false; response_revision:5341; number_of_response:1; }","duration":"109.102775ms","start":"2026-10-17T11:42:15.978694Z","end":"2026-10-17T11:42:16.087796Z","steps":["trace[302567510] 'process raft request' (duration: 108.860329ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:42:16.287214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.715678ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:42:16.287541Z","caller":"traceutil/trace.go:171","msg":"trace[35691943] linearizableReadLoop","detail":"{readStateIndex:5540; appliedIndex:5538; }","duration":"168.736462ms","start":"2026-10-17T11:42:16.118775Z","end":"2026-10-17T11:42:16.287512Z","steps":["trace[35691943] 'read index received' (duration: 1.560503ms)","trace[35691943] 'applied index is now lower than readState.Index' (duration: 167.173939ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:42:16.287547Z","caller":"traceutil/trace.go:171","msg":"trace[256238220] transaction","detail":"{read_only:false; response_revision:5342; number_of_response:1; }","duration":"194.288425ms","start":"2026-10-17T11:42:16.093191Z","end":"2026-10-17T11:42:16.287479Z","steps":["trace[256238220] 'process raft request' (duration: 27.145016ms)","trace[256238220] 'compare' (duration: 166.48409ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:42:16.287636Z","caller":"traceutil/trace.go:171","msg":"trace[1860671261] transaction","detail":"{read_only:false; response_revision:5343; number_of_response:1; }","duration":"181.41193ms","start":"2026-10-17T11:42:16.106172Z","end":"2026-10-17T11:42:16.287584Z","steps":["trace[1860671261] 'process raft request' (duration: 181.247206ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:42:16.287768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.99562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-17T11:42:16.287813Z","caller":"traceutil/trace.go:171","msg":"trace[1989353427] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5343; }","duration":"169.076782ms","start":"2026-10-17T11:42:16.118719Z","end":"2026-10-17T11:42:16.287796Z","steps":["trace[1989353427] 'agreement among raft nodes before linearized reading' (duration: 168.868277ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:16.310144Z","caller":"traceutil/trace.go:171","msg":"trace[909666866] transaction","detail":"{read_only:false; response_revision:5344; number_of_response:1; }","duration":"169.185005ms","start":"2026-10-17T11:42:16.140932Z","end":"2026-10-17T11:42:16.310117Z","steps":["trace[909666866] 'process raft request' (duration: 169.023711ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:16.5859Z","caller":"traceutil/trace.go:171","msg":"trace[1570087135] transaction","detail":"{read_only:false; response_revision:5349; number_of_response:1; }","duration":"118.435391ms","start":"2026-10-17T11:42:16.467434Z","end":"2026-10-17T11:42:16.58587Z","steps":["trace[1570087135] 'process raft request' (duration: 118.061411ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:16.586034Z","caller":"traceutil/trace.go:171","msg":"trace[678647317] transaction","detail":"{read_only:false; response_revision:5348; number_of_response:1; }","duration":"148.288421ms","start":"2026-10-17T11:42:16.437707Z","end":"2026-10-17T11:42:16.585995Z","steps":["trace[678647317] 'process raft request' (duration: 91.102902ms)","trace[678647317] 'compare' (duration: 56.319906ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:42:31.027231Z","caller":"traceutil/trace.go:171","msg":"trace[948057955] transaction","detail":"{read_only:false; response_revision:5626; number_of_response:1; }","duration":"110.090043ms","start":"2026-10-17T11:42:30.917099Z","end":"2026-10-17T11:42:31.027189Z","steps":["trace[948057955] 'process raft request' (duration: 99.77033ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:31.065905Z","caller":"traceutil/trace.go:171","msg":"trace[1375731167] transaction","detail":"{read_only:false; response_revision:5627; number_of_response:1; }","duration":"148.036984ms","start":"2026-10-17T11:42:30.91784Z","end":"2026-10-17T11:42:31.065877Z","steps":["trace[1375731167] 'process raft request' (duration: 147.768347ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:31.066061Z","caller":"traceutil/trace.go:171","msg":"trace[1218866360] linearizableReadLoop","detail":"{readStateIndex:5839; appliedIndex:5832; }","duration":"142.845093ms","start":"2026-10-17T11:42:30.923185Z","end":"2026-10-17T11:42:31.06603Z","steps":["trace[1218866360] 'read index received' (duration: 93.786966ms)","trace[1218866360] 'applied index is now lower than readState.Index' (duration: 49.057006ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:42:31.066216Z","caller":"traceutil/trace.go:171","msg":"trace[1163485068] transaction","detail":"{read_only:false; response_revision:5633; number_of_response:1; }","duration":"142.602295ms","start":"2026-10-17T11:42:30.923601Z","end":"2026-10-17T11:42:31.066203Z","steps":["trace[1163485068] 'process raft request' (duration: 142.368419ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:31.06623Z","caller":"traceutil/trace.go:171","msg":"trace[1335070354] transaction","detail":"{read_only:false; response_revision:5630; number_of_response:1; }","duration":"147.667955ms","start":"2026-10-17T11:42:30.918511Z","end":"2026-10-17T11:42:31.066179Z","steps":["trace[1335070354] 'process raft request' (duration: 147.320715ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:31.066324Z","caller":"traceutil/trace.go:171","msg":"trace[2021017975] transaction","detail":"{read_only:false; response_revision:5629; number_of_response:1; }","duration":"147.898051ms","start":"2026-10-17T11:42:30.918394Z","end":"2026-10-17T11:42:31.066292Z","steps":["trace[2021017975] 'process raft request' (duration: 147.403207ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:31.066438Z","caller":"traceutil/trace.go:171","msg":"trace[122130725] transaction","detail":"{read_only:false; response_revision:5631; number_of_response:1; }","duration":"147.709715ms","start":"2026-10-17T11:42:30.918706Z","end":"2026-10-17T11:42:31.066416Z","steps":["trace[122130725] 'process raft request' (duration: 147.199731ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:31.066537Z","caller":"traceutil/trace.go:171","msg":"trace[251798432] transaction","detail":"{read_only:false; response_revision:5628; number_of_response:1; }","duration":"148.59503ms","start":"2026-10-17T11:42:30.917926Z","end":"2026-10-17T11:42:31.066521Z","steps":["trace[251798432] 'process raft request' (duration: 147.833019ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:31.066669Z","caller":"traceutil/trace.go:171","msg":"trace[1318919996] transaction","detail":"{read_only:false; response_revision:5632; number_of_response:1; }","duration":"147.455529ms","start":"2026-10-17T11:42:30.91916Z","end":"2026-10-17T11:42:31.066616Z","steps":["trace[1318919996] 'process raft request' (duration: 146.77607ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:42:31.066795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.580032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-10-17T11:42:31.07147Z","caller":"traceutil/trace.go:171","msg":"trace[1763497525] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:5633; }","duration":"148.067246ms","start":"2026-10-17T11:42:30.923176Z","end":"2026-10-17T11:42:31.071243Z","steps":["trace[1763497525] 'agreement among raft nodes before linearized reading' (duration: 143.370037ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:31.182699Z","caller":"traceutil/trace.go:171","msg":"trace[472149068] transaction","detail":"{read_only:false; response_revision:5637; number_of_response:1; }","duration":"107.050549ms","start":"2026-10-17T11:42:31.075619Z","end":"2026-10-17T11:42:31.18267Z","steps":["trace[472149068] 'process raft request' (duration: 106.915105ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:31.182892Z","caller":"traceutil/trace.go:171","msg":"trace[325388701] transaction","detail":"{read_only:false; response_revision:5635; number_of_response:1; }","duration":"107.669916ms","start":"2026-10-17T11:42:31.075191Z","end":"2026-10-17T11:42:31.182861Z","steps":["trace[325388701] 'process raft request' (duration: 60.751708ms)","trace[325388701] 'compare' (duration: 46.371793ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:42:31.183048Z","caller":"traceutil/trace.go:171","msg":"trace[1205675789] transaction","detail":"{read_only:false; response_revision:5636; number_of_response:1; }","duration":"107.840671ms","start":"2026-10-17T11:42:31.075194Z","end":"2026-10-17T11:42:31.183035Z","steps":["trace[1205675789] 'process raft request' (duration: 107.271175ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:31.183557Z","caller":"traceutil/trace.go:171","msg":"trace[812862028] transaction","detail":"{read_only:false; response_revision:5638; number_of_response:1; }","duration":"107.841871ms","start":"2026-10-17T11:42:31.075702Z","end":"2026-10-17T11:42:31.183544Z","steps":["trace[812862028] 'process raft request' (duration: 106.894445ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:31.183881Z","caller":"traceutil/trace.go:171","msg":"trace[1790133403] linearizableReadLoop","detail":"{readStateIndex:5845; appliedIndex:5840; }","duration":"105.778024ms","start":"2026-10-17T11:42:31.078062Z","end":"2026-10-17T11:42:31.18384Z","steps":["trace[1790133403] 'read index received' (duration: 40.605245ms)","trace[1790133403] 'applied index is now lower than readState.Index' (duration: 65.169829ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:42:31.183619Z","caller":"traceutil/trace.go:171","msg":"trace[1668366755] transaction","detail":"{read_only:false; response_revision:5639; number_of_response:1; }","duration":"103.889013ms","start":"2026-10-17T11:42:31.079716Z","end":"2026-10-17T11:42:31.183605Z","steps":["trace[1668366755] 'process raft request' (duration: 103.704087ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:42:31.184855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.757091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-10-17T11:42:31.184914Z","caller":"traceutil/trace.go:171","msg":"trace[1208879710] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:5640; }","duration":"106.875574ms","start":"2026-10-17T11:42:31.078023Z","end":"2026-10-17T11:42:31.184898Z","steps":["trace[1208879710] 'agreement among raft nodes before linearized reading' (duration: 105.945269ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:42:31.596616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.66675ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:42:31.596881Z","caller":"traceutil/trace.go:171","msg":"trace[1610681431] transaction","detail":"{read_only:false; response_revision:5645; number_of_response:1; }","duration":"306.972228ms","start":"2026-10-17T11:42:31.289888Z","end":"2026-10-17T11:42:31.59686Z","steps":["trace[1610681431] 'process raft request' (duration: 306.854015ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:42:31.596978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:42:31.28986Z","time spent":"307.065061ms","remote":"127.0.0.1:42904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2413,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:42:31.597003Z","caller":"traceutil/trace.go:171","msg":"trace[507091593] transaction","detail":"{read_only:false; response_revision:5644; number_of_response:1; }","duration":"334.998697ms","start":"2026-10-17T11:42:31.261955Z","end":"2026-10-17T11:42:31.596954Z","steps":["trace[507091593] 'process raft request' (duration: 27.895026ms)","trace[507091593] 'compare' (duration: 306.443483ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:42:31.597133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.761171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls-77hpm\" ","response":"range_response_count:1 size:2600"} {"level":"info","ts":"2026-10-17T11:42:31.596993Z","caller":"traceutil/trace.go:171","msg":"trace[663968227] linearizableReadLoop","detail":"{readStateIndex:5852; appliedIndex:5851; }","duration":"327.408369ms","start":"2026-10-17T11:42:31.269535Z","end":"2026-10-17T11:42:31.596944Z","steps":["trace[663968227] 'read index received' (duration: 20.251946ms)","trace[663968227] 'applied index is now lower than readState.Index' (duration: 307.148773ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:42:31.597215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:42:31.261926Z","time spent":"335.177592ms","remote":"127.0.0.1:50784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":840,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-17T11:42:31.597223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.282652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1825"} {"level":"warn","ts":"2026-10-17T11:42:31.597233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.407057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:4795"} {"level":"info","ts":"2026-10-17T11:42:31.597325Z","caller":"traceutil/trace.go:171","msg":"trace[969279681] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5645; }","duration":"348.410946ms","start":"2026-10-17T11:42:31.24889Z","end":"2026-10-17T11:42:31.597301Z","steps":["trace[969279681] 'agreement among raft nodes before linearized reading' (duration: 348.131998ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:31.597354Z","caller":"traceutil/trace.go:171","msg":"trace[69453239] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:5645; }","duration":"332.570061ms","start":"2026-10-17T11:42:31.264764Z","end":"2026-10-17T11:42:31.597334Z","steps":["trace[69453239] 'agreement among raft nodes before linearized reading' (duration: 332.236932ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:42:31.597351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.804346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"warn","ts":"2026-10-17T11:42:31.597386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:42:31.248881Z","time spent":"348.495298ms","remote":"127.0.0.1:50796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1848,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"warn","ts":"2026-10-17T11:42:31.5974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:42:31.264755Z","time spent":"332.635532ms","remote":"127.0.0.1:50796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":4818,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" "} {"level":"info","ts":"2026-10-17T11:42:31.597419Z","caller":"traceutil/trace.go:171","msg":"trace[633102974] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:5645; }","duration":"360.958801ms","start":"2026-10-17T11:42:31.236439Z","end":"2026-10-17T11:42:31.597397Z","steps":["trace[633102974] 'agreement among raft nodes before linearized reading' (duration: 360.639922ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:31.597278Z","caller":"traceutil/trace.go:171","msg":"trace[692233145] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls-77hpm; range_end:; response_count:1; response_revision:5645; }","duration":"334.915156ms","start":"2026-10-17T11:42:31.262307Z","end":"2026-10-17T11:42:31.597222Z","steps":["trace[692233145] 'agreement among raft nodes before linearized reading' (duration: 334.654979ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:42:31.597454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.518982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-4stqh\" ","response":"range_response_count:1 size:6531"} {"level":"warn","ts":"2026-10-17T11:42:31.597468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:42:31.236414Z","time spent":"361.043772ms","remote":"127.0.0.1:50796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":1,"response size":1366,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" "} {"level":"info","ts":"2026-10-17T11:42:31.597492Z","caller":"traceutil/trace.go:171","msg":"trace[804210564] range","detail":"{range_begin:/registry/pods/openstack/keepalived-4stqh; range_end:; response_count:1; response_revision:5645; }","duration":"229.583034ms","start":"2026-10-17T11:42:31.367898Z","end":"2026-10-17T11:42:31.597481Z","steps":["trace[804210564] 'agreement among raft nodes before linearized reading' (duration: 229.415239ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:42:31.597512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:42:31.262294Z","time spent":"335.182083ms","remote":"127.0.0.1:50796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":2623,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls-77hpm\" "} {"level":"info","ts":"2026-10-17T11:42:31.902974Z","caller":"traceutil/trace.go:171","msg":"trace[1236227271] transaction","detail":"{read_only:false; number_of_response:1; response_revision:5646; }","duration":"302.944167ms","start":"2026-10-17T11:42:31.599994Z","end":"2026-10-17T11:42:31.902938Z","steps":["trace[1236227271] 'process raft request' (duration: 250.742224ms)","trace[1236227271] 'compare' (duration: 51.395431ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:42:31.903302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:42:31.599973Z","time spent":"303.105302ms","remote":"127.0.0.1:50796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":88,"response count":0,"response size":41,"request content":"compare: success: > failure: >"} {"level":"info","ts":"2026-10-17T11:42:31.903482Z","caller":"traceutil/trace.go:171","msg":"trace[1316443015] transaction","detail":"{read_only:false; response_revision:5647; number_of_response:1; }","duration":"300.347196ms","start":"2026-10-17T11:42:31.603094Z","end":"2026-10-17T11:42:31.903441Z","steps":["trace[1316443015] 'process raft request' (duration: 299.76914ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:31.903511Z","caller":"traceutil/trace.go:171","msg":"trace[539027619] linearizableReadLoop","detail":"{readStateIndex:5855; appliedIndex:5853; }","duration":"300.11444ms","start":"2026-10-17T11:42:31.603312Z","end":"2026-10-17T11:42:31.903426Z","steps":["trace[539027619] 'read index received' (duration: 247.513016ms)","trace[539027619] 'applied index is now lower than readState.Index' (duration: 52.592973ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:42:31.903692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:42:31.603069Z","time spent":"300.499991ms","remote":"127.0.0.1:50952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:42:31.903897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.579012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:8 size:70963"} {"level":"info","ts":"2026-10-17T11:42:31.90395Z","caller":"traceutil/trace.go:171","msg":"trace[605123094] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:8; response_revision:5647; }","duration":"300.660675ms","start":"2026-10-17T11:42:31.603278Z","end":"2026-10-17T11:42:31.903938Z","steps":["trace[605123094] 'agreement among raft nodes before linearized reading' (duration: 300.372737ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:42:31.903981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:42:31.603269Z","time spent":"300.704626ms","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":8,"response size":70986,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"warn","ts":"2026-10-17T11:42:31.90407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.329167ms","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":"warn","ts":"2026-10-17T11:42:31.904185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.981137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3684"} {"level":"info","ts":"2026-10-17T11:42:31.90421Z","caller":"traceutil/trace.go:171","msg":"trace[1718451739] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:5647; }","duration":"146.577164ms","start":"2026-10-17T11:42:31.757604Z","end":"2026-10-17T11:42:31.904181Z","steps":["trace[1718451739] 'agreement among raft nodes before linearized reading' (duration: 146.270576ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:31.904236Z","caller":"traceutil/trace.go:171","msg":"trace[64076231] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5647; }","duration":"272.05237ms","start":"2026-10-17T11:42:31.632171Z","end":"2026-10-17T11:42:31.904223Z","steps":["trace[64076231] 'agreement among raft nodes before linearized reading' (duration: 271.848454ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:42:31.9043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.968174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:2428"} {"level":"info","ts":"2026-10-17T11:42:31.904397Z","caller":"traceutil/trace.go:171","msg":"trace[966148945] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:5647; }","duration":"297.094687ms","start":"2026-10-17T11:42:31.607282Z","end":"2026-10-17T11:42:31.904377Z","steps":["trace[966148945] 'agreement among raft nodes before linearized reading' (duration: 296.826619ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:42:31.904441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.380457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.214\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-10-17T11:42:31.904226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.849338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-10-17T11:42:31.904496Z","caller":"traceutil/trace.go:171","msg":"trace[1020057004] range","detail":"{range_begin:/registry/masterleases/162.253.55.214; range_end:; response_count:1; response_revision:5647; }","duration":"123.46357ms","start":"2026-10-17T11:42:31.78102Z","end":"2026-10-17T11:42:31.904484Z","steps":["trace[1020057004] 'agreement among raft nodes before linearized reading' (duration: 123.254224ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:31.904569Z","caller":"traceutil/trace.go:171","msg":"trace[768616762] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:5647; }","duration":"298.268789ms","start":"2026-10-17T11:42:31.606274Z","end":"2026-10-17T11:42:31.904543Z","steps":["trace[768616762] 'agreement among raft nodes before linearized reading' (duration: 297.535459ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:38.568901Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2971} {"level":"info","ts":"2026-10-17T11:42:38.647531Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2971,"took":"76.589052ms","hash":3469103139,"current-db-size-bytes":56201216,"current-db-size":"56 MB","current-db-size-in-use-bytes":31854592,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T11:42:38.647601Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3469103139,"revision":2971,"compact-revision":-1} {"level":"info","ts":"2026-10-17T11:47:38.576698Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5801} {"level":"info","ts":"2026-10-17T11:47:38.671373Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5801,"took":"92.343714ms","hash":4285361229,"current-db-size-bytes":56201216,"current-db-size":"56 MB","current-db-size-in-use-bytes":26300416,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-17T11:47:38.671459Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4285361229,"revision":5801,"compact-revision":2971} {"level":"warn","ts":"2026-10-17T11:49:05.495048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.914032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-10-17T11:49:05.495158Z","caller":"traceutil/trace.go:171","msg":"trace[206559134] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8720; }","duration":"104.086036ms","start":"2026-10-17T11:49:05.391041Z","end":"2026-10-17T11:49:05.495127Z","steps":["trace[206559134] 'range keys from in-memory index tree' (duration: 103.623983ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:49:56.911288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.531608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-10-17T11:49:56.911391Z","caller":"traceutil/trace.go:171","msg":"trace[420577175] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9048; }","duration":"107.705813ms","start":"2026-10-17T11:49:56.803665Z","end":"2026-10-17T11:49:56.911371Z","steps":["trace[420577175] 'range keys from in-memory index tree' (duration: 107.216419ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:49:57.493106Z","caller":"traceutil/trace.go:171","msg":"trace[1919823559] transaction","detail":"{read_only:false; response_revision:9052; number_of_response:1; }","duration":"112.120883ms","start":"2026-10-17T11:49:57.380958Z","end":"2026-10-17T11:49:57.493079Z","steps":["trace[1919823559] 'process raft request' (duration: 111.930798ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:49:58.531139Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024a2.wal"} {"level":"info","ts":"2026-10-17T11:50:01.870245Z","caller":"traceutil/trace.go:171","msg":"trace[23852359] linearizableReadLoop","detail":"{readStateIndex:9404; appliedIndex:9403; }","duration":"110.595701ms","start":"2026-10-17T11:50:01.759616Z","end":"2026-10-17T11:50:01.870212Z","steps":["trace[23852359] 'read index received' (duration: 104.670689ms)","trace[23852359] 'applied index is now lower than readState.Index' (duration: 5.923602ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:50:01.870293Z","caller":"traceutil/trace.go:171","msg":"trace[1504619297] transaction","detail":"{read_only:false; response_revision:9083; number_of_response:1; }","duration":"120.001809ms","start":"2026-10-17T11:50:01.750259Z","end":"2026-10-17T11:50:01.87026Z","steps":["trace[1504619297] 'process raft request' (duration: 114.101597ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:50:01.870517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.874829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-xwjlw\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-10-17T11:50:01.870555Z","caller":"traceutil/trace.go:171","msg":"trace[716246261] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-xwjlw; range_end:; response_count:1; response_revision:9083; }","duration":"110.984442ms","start":"2026-10-17T11:50:01.759558Z","end":"2026-10-17T11:50:01.870542Z","steps":["trace[716246261] 'agreement among raft nodes before linearized reading' (duration: 110.796917ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:50:01.870524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.152916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:50:01.870645Z","caller":"traceutil/trace.go:171","msg":"trace[1636170448] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9083; }","duration":"100.30922ms","start":"2026-10-17T11:50:01.770293Z","end":"2026-10-17T11:50:01.870602Z","steps":["trace[1636170448] 'agreement among raft nodes before linearized reading' (duration: 100.129795ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:51:00.364018Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"86f12f2ae020828","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:51:00.3743Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-17T11:51:00.374421Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-17T11:52:38.5855Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8033} {"level":"info","ts":"2026-10-17T11:52:38.66644Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8033,"took":"78.225007ms","hash":3053484464,"current-db-size-bytes":56201216,"current-db-size":"56 MB","current-db-size-in-use-bytes":28422144,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-17T11:52:38.666532Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3053484464,"revision":8033,"compact-revision":5801} {"level":"info","ts":"2026-10-17T11:57:38.593442Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10402} {"level":"info","ts":"2026-10-17T11:57:38.685307Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10402,"took":"88.542079ms","hash":473584262,"current-db-size-bytes":56201216,"current-db-size":"56 MB","current-db-size-in-use-bytes":25288704,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-10-17T11:57:38.685491Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":473584262,"revision":10402,"compact-revision":8033} {"level":"info","ts":"2026-10-17T12:02:38.601534Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12567} {"level":"info","ts":"2026-10-17T12:02:38.687209Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12567,"took":"82.463379ms","hash":1054141105,"current-db-size-bytes":56201216,"current-db-size":"56 MB","current-db-size-in-use-bytes":27799552,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-17T12:02:38.687293Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1054141105,"revision":12567,"compact-revision":10402} {"level":"warn","ts":"2026-10-17T12:03:23.994881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.269402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-10-17T12:03:23.994936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.187852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T12:03:23.99502Z","caller":"traceutil/trace.go:171","msg":"trace[1127698253] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14917; }","duration":"211.457808ms","start":"2026-10-17T12:03:23.783533Z","end":"2026-10-17T12:03:23.994991Z","steps":["trace[1127698253] 'range keys from in-memory index tree' (duration: 210.995785ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:03:23.995027Z","caller":"traceutil/trace.go:171","msg":"trace[1740698657] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14917; }","duration":"225.329106ms","start":"2026-10-17T12:03:23.769672Z","end":"2026-10-17T12:03:23.995002Z","steps":["trace[1740698657] 'range keys from in-memory index tree' (duration: 225.11575ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:03:23.995089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.932615ms","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-10-17T12:03:23.995148Z","caller":"traceutil/trace.go:171","msg":"trace[2137911795] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14917; }","duration":"225.049449ms","start":"2026-10-17T12:03:23.770085Z","end":"2026-10-17T12:03:23.995134Z","steps":["trace[2137911795] 'range keys from in-memory index tree' (duration: 224.703609ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:03:23.995334Z","caller":"traceutil/trace.go:171","msg":"trace[1739688912] transaction","detail":"{read_only:false; response_revision:14918; number_of_response:1; }","duration":"186.24417ms","start":"2026-10-17T12:03:23.809077Z","end":"2026-10-17T12:03:23.995321Z","steps":["trace[1739688912] 'process raft request' (duration: 102.234638ms)","trace[1739688912] 'compare' (duration: 83.778625ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:03:42.369774Z","caller":"traceutil/trace.go:171","msg":"trace[138528651] linearizableReadLoop","detail":"{readStateIndex:15549; appliedIndex:15548; }","duration":"271.67925ms","start":"2026-10-17T12:03:42.098062Z","end":"2026-10-17T12:03:42.369742Z","steps":["trace[138528651] 'read index received' (duration: 256.448585ms)","trace[138528651] 'applied index is now lower than readState.Index' (duration: 15.229145ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:03:42.369824Z","caller":"traceutil/trace.go:171","msg":"trace[639984365] transaction","detail":"{read_only:false; response_revision:15029; number_of_response:1; }","duration":"272.203324ms","start":"2026-10-17T12:03:42.097574Z","end":"2026-10-17T12:03:42.369777Z","steps":["trace[639984365] 'process raft request' (duration: 256.933328ms)","trace[639984365] 'compare' (duration: 14.855095ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:03:42.370042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.969498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-17T12:03:42.370107Z","caller":"traceutil/trace.go:171","msg":"trace[963081568] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15029; }","duration":"272.067971ms","start":"2026-10-17T12:03:42.098025Z","end":"2026-10-17T12:03:42.370093Z","steps":["trace[963081568] 'agreement among raft nodes before linearized reading' (duration: 271.872126ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:03:42.498978Z","caller":"traceutil/trace.go:171","msg":"trace[235283742] transaction","detail":"{read_only:false; response_revision:15030; number_of_response:1; }","duration":"123.837517ms","start":"2026-10-17T12:03:42.375107Z","end":"2026-10-17T12:03:42.498945Z","steps":["trace[235283742] 'process raft request' (duration: 114.617266ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:04:06.965883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.781777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T12:04:06.966017Z","caller":"traceutil/trace.go:171","msg":"trace[136616147] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15351; }","duration":"196.964412ms","start":"2026-10-17T12:04:06.769016Z","end":"2026-10-17T12:04:06.96598Z","steps":["trace[136616147] 'range keys from in-memory index tree' (duration: 196.654523ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:05:03.896322Z","caller":"traceutil/trace.go:171","msg":"trace[926311105] transaction","detail":"{read_only:false; response_revision:16022; number_of_response:1; }","duration":"101.514397ms","start":"2026-10-17T12:05:03.794739Z","end":"2026-10-17T12:05:03.896254Z","steps":["trace[926311105] 'process raft request' (duration: 101.282121ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:07:38.611013Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14634} {"level":"info","ts":"2026-10-17T12:07:38.709861Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14634,"took":"94.656541ms","hash":2338157046,"current-db-size-bytes":56201216,"current-db-size":"56 MB","current-db-size-in-use-bytes":31301632,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T12:07:38.709949Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2338157046,"revision":14634,"compact-revision":12567} {"level":"info","ts":"2026-10-17T12:11:30.398212Z","caller":"traceutil/trace.go:171","msg":"trace[2112435898] transaction","detail":"{read_only:false; response_revision:18821; number_of_response:1; }","duration":"141.355139ms","start":"2026-10-17T12:11:30.25683Z","end":"2026-10-17T12:11:30.398185Z","steps":["trace[2112435898] 'process raft request' (duration: 140.867025ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:11:36.603722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.487316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-17T12:11:36.603815Z","caller":"traceutil/trace.go:171","msg":"trace[1294471346] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18854; }","duration":"172.648891ms","start":"2026-10-17T12:11:36.431145Z","end":"2026-10-17T12:11:36.603794Z","steps":["trace[1294471346] 'range keys from in-memory index tree' (duration: 172.26397ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:11:36.60421Z","caller":"traceutil/trace.go:171","msg":"trace[1815014165] transaction","detail":"{read_only:false; response_revision:18855; number_of_response:1; }","duration":"170.78583ms","start":"2026-10-17T12:11:36.433327Z","end":"2026-10-17T12:11:36.604113Z","steps":["trace[1815014165] 'process raft request' (duration: 144.663449ms)","trace[1815014165] 'compare' (duration: 25.429942ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:11:36.943015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.541124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T12:11:36.94312Z","caller":"traceutil/trace.go:171","msg":"trace[517495604] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18856; }","duration":"173.721119ms","start":"2026-10-17T12:11:36.769375Z","end":"2026-10-17T12:11:36.943096Z","steps":["trace[517495604] 'range keys from in-memory index tree' (duration: 173.239846ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:11:37.438172Z","caller":"traceutil/trace.go:171","msg":"trace[2066731175] linearizableReadLoop","detail":"{readStateIndex:19504; appliedIndex:19503; }","duration":"197.467836ms","start":"2026-10-17T12:11:37.240563Z","end":"2026-10-17T12:11:37.43803Z","steps":["trace[2066731175] 'read index received' (duration: 142.320335ms)","trace[2066731175] 'applied index is now lower than readState.Index' (duration: 55.145581ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:11:37.438494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.113402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-10-17T12:11:37.438538Z","caller":"traceutil/trace.go:171","msg":"trace[440265385] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18856; }","duration":"159.250956ms","start":"2026-10-17T12:11:37.279276Z","end":"2026-10-17T12:11:37.438527Z","steps":["trace[440265385] 'agreement among raft nodes before linearized reading' (duration: 159.104342ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:11:37.438612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.510163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-17T12:11:37.438731Z","caller":"traceutil/trace.go:171","msg":"trace[1117284862] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18856; }","duration":"148.668588ms","start":"2026-10-17T12:11:37.290036Z","end":"2026-10-17T12:11:37.438705Z","steps":["trace[1117284862] 'agreement among raft nodes before linearized reading' (duration: 148.432381ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:11:37.43913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.889853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-17T12:11:37.439427Z","caller":"traceutil/trace.go:171","msg":"trace[1495098084] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18856; }","duration":"153.252682ms","start":"2026-10-17T12:11:37.286136Z","end":"2026-10-17T12:11:37.439389Z","steps":["trace[1495098084] 'agreement among raft nodes before linearized reading' (duration: 152.760079ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:11:37.439256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.71306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-d8xpm\" ","response":"range_response_count:1 size:22133"} {"level":"info","ts":"2026-10-17T12:11:37.440233Z","caller":"traceutil/trace.go:171","msg":"trace[49852686] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-d8xpm; range_end:; response_count:1; response_revision:18856; }","duration":"199.739108ms","start":"2026-10-17T12:11:37.240473Z","end":"2026-10-17T12:11:37.440212Z","steps":["trace[49852686] 'agreement among raft nodes before linearized reading' (duration: 197.60604ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:12:16.672787Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"86f12f2ae020828","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T12:12:16.685866Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-17T12:12:16.686013Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-17T12:12:38.620303Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17047} {"level":"info","ts":"2026-10-17T12:12:38.728047Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17047,"took":"103.424596ms","hash":17809660,"current-db-size-bytes":56201216,"current-db-size":"56 MB","current-db-size-in-use-bytes":33460224,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-17T12:12:38.728128Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":17809660,"revision":17047,"compact-revision":14634} {"level":"info","ts":"2026-10-17T12:17:29.14824Z","caller":"traceutil/trace.go:171","msg":"trace[694601752] transaction","detail":"{read_only:false; response_revision:21565; number_of_response:1; }","duration":"304.664926ms","start":"2026-10-17T12:17:28.843535Z","end":"2026-10-17T12:17:29.1482Z","steps":["trace[694601752] 'process raft request' (duration: 224.277507ms)","trace[694601752] 'compare' (duration: 79.71432ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:17:29.148492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:17:28.843516Z","time spent":"304.83912ms","remote":"127.0.0.1:50952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T12:17:29.148569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.701046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-10-17T12:17:29.14866Z","caller":"traceutil/trace.go:171","msg":"trace[1525290147] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21565; }","duration":"185.865181ms","start":"2026-10-17T12:17:28.962783Z","end":"2026-10-17T12:17:29.148648Z","steps":["trace[1525290147] 'agreement among raft nodes before linearized reading' (duration: 185.605064ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:17:29.148358Z","caller":"traceutil/trace.go:171","msg":"trace[1585429737] linearizableReadLoop","detail":"{readStateIndex:22302; appliedIndex:22301; }","duration":"185.47109ms","start":"2026-10-17T12:17:28.962857Z","end":"2026-10-17T12:17:29.148328Z","steps":["trace[1585429737] 'read index received' (duration: 105.072151ms)","trace[1585429737] 'applied index is now lower than readState.Index' (duration: 80.397319ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:17:29.171308Z","caller":"traceutil/trace.go:171","msg":"trace[1370797604] transaction","detail":"{read_only:false; response_revision:21566; number_of_response:1; }","duration":"159.77702ms","start":"2026-10-17T12:17:29.011499Z","end":"2026-10-17T12:17:29.171276Z","steps":["trace[1370797604] 'process raft request' (duration: 159.549463ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:17:29.171742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.302617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-10-17T12:17:29.172186Z","caller":"traceutil/trace.go:171","msg":"trace[153253782] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:21566; }","duration":"177.799691ms","start":"2026-10-17T12:17:28.994355Z","end":"2026-10-17T12:17:29.172155Z","steps":["trace[153253782] 'agreement among raft nodes before linearized reading' (duration: 177.169913ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:17:29.434375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.647347ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T12:17:29.434544Z","caller":"traceutil/trace.go:171","msg":"trace[459061331] linearizableReadLoop","detail":"{readStateIndex:22304; appliedIndex:22303; }","duration":"189.87931ms","start":"2026-10-17T12:17:29.244637Z","end":"2026-10-17T12:17:29.434516Z","steps":["trace[459061331] 'read index received' (duration: 51.968245ms)","trace[459061331] 'applied index is now lower than readState.Index' (duration: 137.909635ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:17:29.434585Z","caller":"traceutil/trace.go:171","msg":"trace[907300544] transaction","detail":"{read_only:false; response_revision:21567; number_of_response:1; }","duration":"256.757961ms","start":"2026-10-17T12:17:29.177797Z","end":"2026-10-17T12:17:29.434555Z","steps":["trace[907300544] 'process raft request' (duration: 118.804615ms)","trace[907300544] 'compare' (duration: 137.298898ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:17:29.43471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.074005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T12:17:29.434777Z","caller":"traceutil/trace.go:171","msg":"trace[2129219456] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:21567; }","duration":"190.155547ms","start":"2026-10-17T12:17:29.244597Z","end":"2026-10-17T12:17:29.434753Z","steps":["trace[2129219456] 'agreement among raft nodes before linearized reading' (duration: 189.995923ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:17:29.799343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.512392ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T12:17:29.799518Z","caller":"traceutil/trace.go:171","msg":"trace[1053032676] linearizableReadLoop","detail":"{readStateIndex:22306; appliedIndex:22304; }","duration":"339.767441ms","start":"2026-10-17T12:17:29.459724Z","end":"2026-10-17T12:17:29.799492Z","steps":["trace[1053032676] 'read index received' (duration: 15.337308ms)","trace[1053032676] 'applied index is now lower than readState.Index' (duration: 324.427703ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:17:29.799628Z","caller":"traceutil/trace.go:171","msg":"trace[792289958] transaction","detail":"{read_only:false; response_revision:21569; number_of_response:1; }","duration":"346.886105ms","start":"2026-10-17T12:17:29.452722Z","end":"2026-10-17T12:17:29.799608Z","steps":["trace[792289958] 'process raft request' (duration: 164.960082ms)","trace[792289958] 'compare' (duration: 181.341277ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:17:29.799725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:17:29.452694Z","time spent":"346.979877ms","remote":"127.0.0.1:50952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T12:17:29.799919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.160671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"} {"level":"info","ts":"2026-10-17T12:17:29.799987Z","caller":"traceutil/trace.go:171","msg":"trace[1039019727] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:21569; }","duration":"340.274655ms","start":"2026-10-17T12:17:29.459692Z","end":"2026-10-17T12:17:29.799967Z","steps":["trace[1039019727] 'agreement among raft nodes before linearized reading' (duration: 340.09212ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:17:29.800033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:17:29.45968Z","time spent":"340.341066ms","remote":"127.0.0.1:54936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5675,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-10-17T12:17:29.841163Z","caller":"traceutil/trace.go:171","msg":"trace[1732994519] transaction","detail":"{read_only:false; response_revision:21570; number_of_response:1; }","duration":"317.989728ms","start":"2026-10-17T12:17:29.523113Z","end":"2026-10-17T12:17:29.841102Z","steps":["trace[1732994519] 'process raft request' (duration: 317.675159ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:17:29.841246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.019344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-10-17T12:17:29.841239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.365397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-17T12:17:29.841309Z","caller":"traceutil/trace.go:171","msg":"trace[1730374790] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21570; }","duration":"179.130157ms","start":"2026-10-17T12:17:29.662161Z","end":"2026-10-17T12:17:29.841291Z","steps":["trace[1730374790] 'agreement among raft nodes before linearized reading' (duration: 178.87952ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:17:29.841299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.748707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-17T12:17:29.841333Z","caller":"traceutil/trace.go:171","msg":"trace[901654878] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21570; }","duration":"210.534592ms","start":"2026-10-17T12:17:29.630775Z","end":"2026-10-17T12:17:29.841309Z","steps":["trace[901654878] 'agreement among raft nodes before linearized reading' (duration: 210.228694ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:17:29.841373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:17:29.523088Z","time spent":"318.169263ms","remote":"127.0.0.1:50952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T12:17:29.84138Z","caller":"traceutil/trace.go:171","msg":"trace[160511029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21570; }","duration":"196.87156ms","start":"2026-10-17T12:17:29.644486Z","end":"2026-10-17T12:17:29.841357Z","steps":["trace[160511029] 'agreement among raft nodes before linearized reading' (duration: 196.660904ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:17:30.101682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.523221ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T12:17:30.101823Z","caller":"traceutil/trace.go:171","msg":"trace[1015349487] transaction","detail":"{read_only:false; response_revision:21571; number_of_response:1; }","duration":"255.949819ms","start":"2026-10-17T12:17:29.845848Z","end":"2026-10-17T12:17:30.101798Z","steps":["trace[1015349487] 'process raft request' (duration: 135.189381ms)","trace[1015349487] 'compare' (duration: 120.233993ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:17:30.104676Z","caller":"traceutil/trace.go:171","msg":"trace[1050276590] transaction","detail":"{read_only:false; response_revision:21573; number_of_response:1; }","duration":"258.412545ms","start":"2026-10-17T12:17:29.846231Z","end":"2026-10-17T12:17:30.104643Z","steps":["trace[1050276590] 'process raft request' (duration: 258.353143ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:17:30.10475Z","caller":"traceutil/trace.go:171","msg":"trace[1097006262] transaction","detail":"{read_only:false; response_revision:21572; number_of_response:1; }","duration":"258.57007ms","start":"2026-10-17T12:17:29.846131Z","end":"2026-10-17T12:17:30.104701Z","steps":["trace[1097006262] 'process raft request' (duration: 258.173349ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:17:38.632113Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19543} {"level":"info","ts":"2026-10-17T12:17:38.768913Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19543,"took":"132.59431ms","hash":318737286,"current-db-size-bytes":56201216,"current-db-size":"56 MB","current-db-size-in-use-bytes":29818880,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-17T12:17:38.768997Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":318737286,"revision":19543,"compact-revision":17047} {"level":"info","ts":"2026-10-17T12:21:34.730399Z","caller":"traceutil/trace.go:171","msg":"trace[2118439258] transaction","detail":"{read_only:false; response_revision:24078; number_of_response:1; }","duration":"128.935175ms","start":"2026-10-17T12:21:34.601423Z","end":"2026-10-17T12:21:34.730358Z","steps":["trace[2118439258] 'process raft request' (duration: 54.505713ms)","trace[2118439258] 'compare' (duration: 73.97397ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:21:35.02691Z","caller":"traceutil/trace.go:171","msg":"trace[2009763070] transaction","detail":"{read_only:false; response_revision:24080; number_of_response:1; }","duration":"191.302193ms","start":"2026-10-17T12:21:34.835569Z","end":"2026-10-17T12:21:35.026871Z","steps":["trace[2009763070] 'process raft request' (duration: 188.106707ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:21:35.040544Z","caller":"traceutil/trace.go:171","msg":"trace[1507373266] transaction","detail":"{read_only:false; response_revision:24081; number_of_response:1; }","duration":"175.120805ms","start":"2026-10-17T12:21:34.865379Z","end":"2026-10-17T12:21:35.0405Z","steps":["trace[1507373266] 'process raft request' (duration: 174.769816ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:21:35.040586Z","caller":"traceutil/trace.go:171","msg":"trace[1948278150] transaction","detail":"{read_only:false; response_revision:24082; number_of_response:1; }","duration":"146.880272ms","start":"2026-10-17T12:21:34.893675Z","end":"2026-10-17T12:21:35.040556Z","steps":["trace[1948278150] 'process raft request' (duration: 146.636015ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:22:38.641479Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21616} {"level":"info","ts":"2026-10-17T12:22:38.768013Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21616,"took":"121.714181ms","hash":1815240459,"current-db-size-bytes":56201216,"current-db-size":"56 MB","current-db-size-in-use-bytes":43028480,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-10-17T12:22:38.768088Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1815240459,"revision":21616,"compact-revision":19543} {"level":"info","ts":"2026-10-17T12:25:03.844741Z","caller":"traceutil/trace.go:171","msg":"trace[1021721304] transaction","detail":"{read_only:false; response_revision:26117; number_of_response:1; }","duration":"103.897259ms","start":"2026-10-17T12:25:03.740815Z","end":"2026-10-17T12:25:03.844712Z","steps":["trace[1021721304] 'process raft request' (duration: 103.705834ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:25:04.053188Z","caller":"traceutil/trace.go:171","msg":"trace[990013486] linearizableReadLoop","detail":"{readStateIndex:26985; appliedIndex:26984; }","duration":"111.546616ms","start":"2026-10-17T12:25:03.941597Z","end":"2026-10-17T12:25:04.053144Z","steps":["trace[990013486] 'read index received' (duration: 109.765738ms)","trace[990013486] 'applied index is now lower than readState.Index' (duration: 1.776598ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:25:04.053262Z","caller":"traceutil/trace.go:171","msg":"trace[424118324] transaction","detail":"{read_only:false; response_revision:26119; number_of_response:1; }","duration":"107.395495ms","start":"2026-10-17T12:25:03.945827Z","end":"2026-10-17T12:25:04.053223Z","steps":["trace[424118324] 'process raft request' (duration: 107.261061ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:25:04.053593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.964548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-17T12:25:04.053698Z","caller":"traceutil/trace.go:171","msg":"trace[131372848] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26119; }","duration":"112.150833ms","start":"2026-10-17T12:25:03.941526Z","end":"2026-10-17T12:25:04.053676Z","steps":["trace[131372848] 'agreement among raft nodes before linearized reading' (duration: 111.695321ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:25:04.053183Z","caller":"traceutil/trace.go:171","msg":"trace[1914890920] transaction","detail":"{read_only:false; response_revision:26118; number_of_response:1; }","duration":"119.136541ms","start":"2026-10-17T12:25:03.933967Z","end":"2026-10-17T12:25:04.053103Z","steps":["trace[1914890920] 'process raft request' (duration: 117.266061ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:25:04.226555Z","caller":"traceutil/trace.go:171","msg":"trace[1960890393] transaction","detail":"{read_only:false; response_revision:26120; number_of_response:1; }","duration":"167.014766ms","start":"2026-10-17T12:25:04.059497Z","end":"2026-10-17T12:25:04.226511Z","steps":["trace[1960890393] 'process raft request' (duration: 96.8825ms)","trace[1960890393] 'compare' (duration: 69.951191ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:25:04.35622Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006970.wal"} {"level":"warn","ts":"2026-10-17T12:26:08.786375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.978123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-17T12:26:08.786499Z","caller":"traceutil/trace.go:171","msg":"trace[1454667044] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26712; }","duration":"198.166779ms","start":"2026-10-17T12:26:08.588309Z","end":"2026-10-17T12:26:08.786476Z","steps":["trace[1454667044] 'range keys from in-memory index tree' (duration: 197.729047ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:26:08.891997Z","caller":"traceutil/trace.go:171","msg":"trace[632009162] linearizableReadLoop","detail":"{readStateIndex:27595; appliedIndex:27594; }","duration":"132.029591ms","start":"2026-10-17T12:26:08.759936Z","end":"2026-10-17T12:26:08.891966Z","steps":["trace[632009162] 'read index received' (duration: 131.778504ms)","trace[632009162] 'applied index is now lower than readState.Index' (duration: 249.016µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:26:08.892106Z","caller":"traceutil/trace.go:171","msg":"trace[2019359651] transaction","detail":"{read_only:false; response_revision:26713; number_of_response:1; }","duration":"272.895869ms","start":"2026-10-17T12:26:08.619133Z","end":"2026-10-17T12:26:08.892028Z","steps":["trace[2019359651] 'process raft request' (duration: 272.597641ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:26:08.892407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.447481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:561"} {"level":"info","ts":"2026-10-17T12:26:08.892534Z","caller":"traceutil/trace.go:171","msg":"trace[349538742] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:26713; }","duration":"132.647517ms","start":"2026-10-17T12:26:08.75986Z","end":"2026-10-17T12:26:08.892507Z","steps":["trace[349538742] 'agreement among raft nodes before linearized reading' (duration: 132.257477ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:26:09.000149Z","caller":"traceutil/trace.go:171","msg":"trace[839628904] transaction","detail":"{read_only:false; response_revision:26715; number_of_response:1; }","duration":"102.334767ms","start":"2026-10-17T12:26:08.897787Z","end":"2026-10-17T12:26:09.000122Z","steps":["trace[839628904] 'process raft request' (duration: 102.267545ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:26:09.000321Z","caller":"traceutil/trace.go:171","msg":"trace[2120173] transaction","detail":"{read_only:false; response_revision:26714; number_of_response:1; }","duration":"208.612871ms","start":"2026-10-17T12:26:08.791699Z","end":"2026-10-17T12:26:09.000312Z","steps":["trace[2120173] 'process raft request' (duration: 206.646278ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:26:09.000423Z","caller":"traceutil/trace.go:171","msg":"trace[317058423] linearizableReadLoop","detail":"{readStateIndex:27596; appliedIndex:27595; }","duration":"108.306419ms","start":"2026-10-17T12:26:08.892091Z","end":"2026-10-17T12:26:09.000398Z","steps":["trace[317058423] 'read index received' (duration: 106.251663ms)","trace[317058423] 'applied index is now lower than readState.Index' (duration: 2.051885ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:26:09.000612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.28825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-17T12:26:09.000687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.946355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T12:26:09.0008Z","caller":"traceutil/trace.go:171","msg":"trace[1903991636] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26715; }","duration":"231.14487ms","start":"2026-10-17T12:26:08.769628Z","end":"2026-10-17T12:26:09.000773Z","steps":["trace[1903991636] 'agreement among raft nodes before linearized reading' (duration: 230.911563ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:26:09.000725Z","caller":"traceutil/trace.go:171","msg":"trace[1801450781] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:26715; }","duration":"111.491805ms","start":"2026-10-17T12:26:08.889205Z","end":"2026-10-17T12:26:09.000697Z","steps":["trace[1801450781] 'agreement among raft nodes before linearized reading' (duration: 111.270479ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:26:09.329335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.48986ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T12:26:09.329525Z","caller":"traceutil/trace.go:171","msg":"trace[1289828830] transaction","detail":"{read_only:false; response_revision:26717; number_of_response:1; }","duration":"237.394689ms","start":"2026-10-17T12:26:09.092095Z","end":"2026-10-17T12:26:09.32949Z","steps":["trace[1289828830] 'process raft request' (duration: 66.641372ms)","trace[1289828830] 'compare' (duration: 169.425852ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:27:38.652486Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24782} {"level":"info","ts":"2026-10-17T12:27:38.811547Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24782,"took":"152.952093ms","hash":3836934942,"current-db-size-bytes":57044992,"current-db-size":"57 MB","current-db-size-in-use-bytes":36081664,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-17T12:27:38.811634Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3836934942,"revision":24782,"compact-revision":21616} {"level":"info","ts":"2026-10-17T12:30:06.455068Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"86f12f2ae020828","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T12:30:06.462339Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-17T12:30:06.462524Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-17T12:32:38.661566Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27597} {"level":"info","ts":"2026-10-17T12:32:38.808645Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27597,"took":"138.238095ms","hash":185933499,"current-db-size-bytes":57044992,"current-db-size":"57 MB","current-db-size-in-use-bytes":36925440,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-10-17T12:32:38.80875Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":185933499,"revision":27597,"compact-revision":24782} {"level":"info","ts":"2026-10-17T12:37:38.669632Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30244} {"level":"info","ts":"2026-10-17T12:37:38.825209Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30244,"took":"150.111127ms","hash":1683229664,"current-db-size-bytes":57044992,"current-db-size":"57 MB","current-db-size-in-use-bytes":30507008,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-17T12:37:38.825308Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1683229664,"revision":30244,"compact-revision":27597} {"level":"info","ts":"2026-10-17T12:42:38.679523Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32495} {"level":"info","ts":"2026-10-17T12:42:38.841107Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32495,"took":"152.704557ms","hash":1599576499,"current-db-size-bytes":57044992,"current-db-size":"57 MB","current-db-size-in-use-bytes":30113792,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-17T12:42:38.841196Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1599576499,"revision":32495,"compact-revision":30244} {"level":"info","ts":"2026-10-17T12:47:38.687583Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34715} {"level":"info","ts":"2026-10-17T12:47:38.81884Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34715,"took":"125.34534ms","hash":1378926018,"current-db-size-bytes":57044992,"current-db-size":"57 MB","current-db-size-in-use-bytes":31096832,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T12:47:38.818897Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1378926018,"revision":34715,"compact-revision":32495} {"level":"info","ts":"2026-10-17T12:51:30.600422Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"86f12f2ae020828","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T12:51:30.610063Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-17T12:51:30.610245Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-17T12:52:38.696852Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37010} {"level":"info","ts":"2026-10-17T12:52:38.836631Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37010,"took":"133.404379ms","hash":2480459809,"current-db-size-bytes":57044992,"current-db-size":"57 MB","current-db-size-in-use-bytes":32894976,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-17T12:52:38.836717Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2480459809,"revision":37010,"compact-revision":34715} {"level":"info","ts":"2026-10-17T12:57:38.705609Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39283} {"level":"info","ts":"2026-10-17T12:57:38.853581Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39283,"took":"142.18441ms","hash":3745352594,"current-db-size-bytes":57892864,"current-db-size":"58 MB","current-db-size-in-use-bytes":31899648,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T12:57:38.853663Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3745352594,"revision":39283,"compact-revision":37010}