{"level":"warn","ts":"2026-04-27T01:20:57.006093Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T01:20:57.006182Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.113:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.113:2380","--initial-cluster=instance=https://199.204.45.113:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.113:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.113:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-27T01:20:57.00625Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T01:20:57.00627Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-04-27T01:20:57.006293Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-27T01:20:57.007098Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"]} {"level":"info","ts":"2026-04-27T01:20:57.007181Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.113:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-27T01:20:57.011915Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.562638ms"} {"level":"info","ts":"2026-04-27T01:20:57.026987Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a31e123290fcf0df","cluster-id":"37661d6ee45ed9e8"} {"level":"info","ts":"2026-04-27T01:20:57.027122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=()"} {"level":"info","ts":"2026-04-27T01:20:57.027152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 0"} {"level":"info","ts":"2026-04-27T01:20:57.027167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a31e123290fcf0df [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-27T01:20:57.027178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 1"} {"level":"info","ts":"2026-04-27T01:20:57.027224Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"warn","ts":"2026-04-27T01:20:57.04151Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-27T01:20:57.043028Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-27T01:20:57.046733Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-27T01:20:57.049884Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a31e123290fcf0df","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-27T01:20:57.050404Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T01:20:57.050483Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T01:20:57.050495Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T01:20:57.050677Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a31e123290fcf0df","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-27T01:20:57.052152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"info","ts":"2026-04-27T01:20:57.052343Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","added-peer-id":"a31e123290fcf0df","added-peer-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-04-27T01:20:57.053836Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-27T01:20:57.054Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-04-27T01:20:57.054022Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-04-27T01:20:57.054061Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a31e123290fcf0df","initial-advertise-peer-urls":["https://199.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-27T01:20:57.054101Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-27T01:20:57.827898Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df is starting a new election at term 1"} {"level":"info","ts":"2026-04-27T01:20:57.827963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became pre-candidate at term 1"} {"level":"info","ts":"2026-04-27T01:20:57.828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgPreVoteResp from a31e123290fcf0df at term 1"} {"level":"info","ts":"2026-04-27T01:20:57.828019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became candidate at term 2"} {"level":"info","ts":"2026-04-27T01:20:57.828031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgVoteResp from a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-04-27T01:20:57.828046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became leader at term 2"} {"level":"info","ts":"2026-04-27T01:20:57.82806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a31e123290fcf0df elected leader a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-04-27T01:20:57.828856Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a31e123290fcf0df","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.113:2379]}","request-path":"/0/members/a31e123290fcf0df/attributes","cluster-id":"37661d6ee45ed9e8","publish-timeout":"7s"} {"level":"info","ts":"2026-04-27T01:20:57.829004Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T01:20:57.828926Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T01:20:57.82916Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T01:20:57.829823Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-27T01:20:57.829848Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-27T01:20:57.829991Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T01:20:57.830099Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T01:20:57.830128Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T01:20:57.831147Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.113:2379"} {"level":"info","ts":"2026-04-27T01:20:57.832356Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-27T01:21:03.570505Z","caller":"traceutil/trace.go:171","msg":"trace[304260402] transaction","detail":"{read_only:false; response_revision:255; number_of_response:1; }","duration":"140.112957ms","start":"2026-04-27T01:21:03.430351Z","end":"2026-04-27T01:21:03.570464Z","steps":["trace[304260402] 'process raft request' (duration: 124.350894ms)","trace[304260402] 'compare' (duration: 15.551361ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:21:03.578068Z","caller":"traceutil/trace.go:171","msg":"trace[1973746607] linearizableReadLoop","detail":"{readStateIndex:266; appliedIndex:264; }","duration":"102.51979ms","start":"2026-04-27T01:21:03.475537Z","end":"2026-04-27T01:21:03.578057Z","steps":["trace[1973746607] 'read index received' (duration: 79.310154ms)","trace[1973746607] 'applied index is now lower than readState.Index' (duration: 23.209006ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:21:03.57817Z","caller":"traceutil/trace.go:171","msg":"trace[1335134427] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"115.167984ms","start":"2026-04-27T01:21:03.462942Z","end":"2026-04-27T01:21:03.57811Z","steps":["trace[1335134427] 'process raft request' (duration: 115.038033ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:21:03.578275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.720712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:21:03.578381Z","caller":"traceutil/trace.go:171","msg":"trace[717338065] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:256; }","duration":"102.858084ms","start":"2026-04-27T01:21:03.475496Z","end":"2026-04-27T01:21:03.578354Z","steps":["trace[717338065] 'agreement among raft nodes before linearized reading' (duration: 102.632052ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:21:09.241164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.003563ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-27T01:21:09.241313Z","caller":"traceutil/trace.go:171","msg":"trace[1215699866] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"379.693458ms","start":"2026-04-27T01:21:08.861599Z","end":"2026-04-27T01:21:09.241293Z","steps":["trace[1215699866] 'process raft request' (duration: 120.787866ms)","trace[1215699866] 'compare' (duration: 257.399328ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:21:09.241403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:21:08.86157Z","time spent":"379.80457ms","remote":"127.0.0.1:59964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T01:21:09.544883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.431433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-27T01:21:09.545067Z","caller":"traceutil/trace.go:171","msg":"trace[781094376] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:354; }","duration":"143.482143ms","start":"2026-04-27T01:21:09.401557Z","end":"2026-04-27T01:21:09.545039Z","steps":["trace[781094376] 'range keys from in-memory index tree' (duration: 141.990038ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:09.724057Z","caller":"traceutil/trace.go:171","msg":"trace[683101761] linearizableReadLoop","detail":"{readStateIndex:367; appliedIndex:366; }","duration":"134.45499ms","start":"2026-04-27T01:21:09.58957Z","end":"2026-04-27T01:21:09.724025Z","steps":["trace[683101761] 'read index received' (duration: 134.279269ms)","trace[683101761] 'applied index is now lower than readState.Index' (duration: 174.611µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:21:09.724251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.661393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T01:21:09.7242Z","caller":"traceutil/trace.go:171","msg":"trace[99884753] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"174.664658ms","start":"2026-04-27T01:21:09.549438Z","end":"2026-04-27T01:21:09.724103Z","steps":["trace[99884753] 'process raft request' (duration: 174.344315ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:09.72429Z","caller":"traceutil/trace.go:171","msg":"trace[1449069235] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:355; }","duration":"134.798214ms","start":"2026-04-27T01:21:09.589481Z","end":"2026-04-27T01:21:09.724279Z","steps":["trace[1449069235] 'agreement among raft nodes before linearized reading' (duration: 134.698223ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:28.964235Z","caller":"traceutil/trace.go:171","msg":"trace[444144461] transaction","detail":"{read_only:false; number_of_response:1; response_revision:482; }","duration":"193.80113ms","start":"2026-04-27T01:21:28.770396Z","end":"2026-04-27T01:21:28.964197Z","steps":["trace[444144461] 'process raft request' (duration: 188.492228ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:28.964692Z","caller":"traceutil/trace.go:171","msg":"trace[1073822737] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"167.551914ms","start":"2026-04-27T01:21:28.797122Z","end":"2026-04-27T01:21:28.964674Z","steps":["trace[1073822737] 'process raft request' (duration: 167.380213ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:28.964786Z","caller":"traceutil/trace.go:171","msg":"trace[636368094] transaction","detail":"{read_only:false; number_of_response:0; response_revision:483; }","duration":"167.635245ms","start":"2026-04-27T01:21:28.797123Z","end":"2026-04-27T01:21:28.964758Z","steps":["trace[636368094] 'process raft request' (duration: 167.510024ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:28.964886Z","caller":"traceutil/trace.go:171","msg":"trace[449871979] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"167.667896ms","start":"2026-04-27T01:21:28.797175Z","end":"2026-04-27T01:21:28.964843Z","steps":["trace[449871979] 'process raft request' (duration: 167.488164ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:28.964946Z","caller":"traceutil/trace.go:171","msg":"trace[1272758581] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"166.513425ms","start":"2026-04-27T01:21:28.798418Z","end":"2026-04-27T01:21:28.964931Z","steps":["trace[1272758581] 'process raft request' (duration: 166.291654ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:28.965215Z","caller":"traceutil/trace.go:171","msg":"trace[1861621081] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"165.79595ms","start":"2026-04-27T01:21:28.79939Z","end":"2026-04-27T01:21:28.965186Z","steps":["trace[1861621081] 'process raft request' (duration: 165.418187ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:28.965292Z","caller":"traceutil/trace.go:171","msg":"trace[831359442] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"164.144687ms","start":"2026-04-27T01:21:28.801132Z","end":"2026-04-27T01:21:28.965276Z","steps":["trace[831359442] 'process raft request' (duration: 163.803124ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:28.965375Z","caller":"traceutil/trace.go:171","msg":"trace[248266602] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"159.787124ms","start":"2026-04-27T01:21:28.805579Z","end":"2026-04-27T01:21:28.965366Z","steps":["trace[248266602] 'process raft request' (duration: 159.616372ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:28.965589Z","caller":"traceutil/trace.go:171","msg":"trace[1065587322] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"154.601463ms","start":"2026-04-27T01:21:28.810978Z","end":"2026-04-27T01:21:28.965579Z","steps":["trace[1065587322] 'process raft request' (duration: 154.252369ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:28.965797Z","caller":"traceutil/trace.go:171","msg":"trace[1085502700] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"108.010637ms","start":"2026-04-27T01:21:28.857752Z","end":"2026-04-27T01:21:28.965762Z","steps":["trace[1085502700] 'process raft request' (duration: 107.848126ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:28.966096Z","caller":"traceutil/trace.go:171","msg":"trace[857294256] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"154.600532ms","start":"2026-04-27T01:21:28.811485Z","end":"2026-04-27T01:21:28.966086Z","steps":["trace[857294256] 'process raft request' (duration: 153.881236ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:28.966726Z","caller":"traceutil/trace.go:171","msg":"trace[1985039274] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"149.917647ms","start":"2026-04-27T01:21:28.816789Z","end":"2026-04-27T01:21:28.966707Z","steps":["trace[1985039274] 'process raft request' (duration: 148.664057ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:34.967682Z","caller":"traceutil/trace.go:171","msg":"trace[4294309] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"110.629347ms","start":"2026-04-27T01:21:34.857023Z","end":"2026-04-27T01:21:34.967652Z","steps":["trace[4294309] 'process raft request' (duration: 110.386925ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:21:35.192934Z","caller":"traceutil/trace.go:171","msg":"trace[1782355084] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"266.714071ms","start":"2026-04-27T01:21:34.926188Z","end":"2026-04-27T01:21:35.192902Z","steps":["trace[1782355084] 'process raft request' (duration: 266.173347ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:21:35.836779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.659442ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-27T01:21:35.837015Z","caller":"traceutil/trace.go:171","msg":"trace[2142316496] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:601; }","duration":"491.828842ms","start":"2026-04-27T01:21:35.34516Z","end":"2026-04-27T01:21:35.836989Z","steps":["trace[2142316496] 'read index received' (duration: 92.001µs)","trace[2142316496] 'applied index is now lower than readState.Index' (duration: 491.73432ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:21:35.837168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.999284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:21:35.837232Z","caller":"traceutil/trace.go:171","msg":"trace[1097414452] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:579; }","duration":"492.125014ms","start":"2026-04-27T01:21:35.345088Z","end":"2026-04-27T01:21:35.837213Z","steps":["trace[1097414452] 'agreement among raft nodes before linearized reading' (duration: 491.966193ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:21:35.837282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:21:35.345048Z","time spent":"492.222076ms","remote":"127.0.0.1:59436","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-04-27T01:21:35.837254Z","caller":"traceutil/trace.go:171","msg":"trace[1733395377] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"587.296461ms","start":"2026-04-27T01:21:35.249861Z","end":"2026-04-27T01:21:35.837157Z","steps":["trace[1733395377] 'process raft request' (duration: 39.126525ms)","trace[1733395377] 'compare' (duration: 546.891676ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:21:35.837709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:21:35.249826Z","time spent":"587.684083ms","remote":"127.0.0.1:59954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T01:22:08.807873Z","caller":"traceutil/trace.go:171","msg":"trace[763901516] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"103.314592ms","start":"2026-04-27T01:22:08.704525Z","end":"2026-04-27T01:22:08.807839Z","steps":["trace[763901516] 'process raft request' (duration: 103.132915ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:22:08.807932Z","caller":"traceutil/trace.go:171","msg":"trace[1299903291] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"101.655698ms","start":"2026-04-27T01:22:08.70626Z","end":"2026-04-27T01:22:08.807915Z","steps":["trace[1299903291] 'process raft request' (duration: 101.523673ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:22:40.430532Z","caller":"traceutil/trace.go:171","msg":"trace[151840289] transaction","detail":"{read_only:false; response_revision:1389; number_of_response:1; }","duration":"144.236264ms","start":"2026-04-27T01:22:40.286268Z","end":"2026-04-27T01:22:40.430504Z","steps":["trace[151840289] 'process raft request' (duration: 144.052729ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:22:40.431306Z","caller":"traceutil/trace.go:171","msg":"trace[1972515486] linearizableReadLoop","detail":"{readStateIndex:1435; appliedIndex:1435; }","duration":"141.438488ms","start":"2026-04-27T01:22:40.289849Z","end":"2026-04-27T01:22:40.431287Z","steps":["trace[1972515486] 'read index received' (duration: 141.430518ms)","trace[1972515486] 'applied index is now lower than readState.Index' (duration: 6.59µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:22:40.431506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.636373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-27T01:22:40.431544Z","caller":"traceutil/trace.go:171","msg":"trace[1040800651] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1389; }","duration":"141.714214ms","start":"2026-04-27T01:22:40.289821Z","end":"2026-04-27T01:22:40.431536Z","steps":["trace[1040800651] 'agreement among raft nodes before linearized reading' (duration: 141.5602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:22:40.44166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.738789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-27T01:22:40.441668Z","caller":"traceutil/trace.go:171","msg":"trace[820864860] transaction","detail":"{read_only:false; response_revision:1390; number_of_response:1; }","duration":"151.639827ms","start":"2026-04-27T01:22:40.289986Z","end":"2026-04-27T01:22:40.441626Z","steps":["trace[820864860] 'process raft request' (duration: 151.472422ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:22:40.441711Z","caller":"traceutil/trace.go:171","msg":"trace[946681603] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1390; }","duration":"151.807552ms","start":"2026-04-27T01:22:40.289888Z","end":"2026-04-27T01:22:40.441696Z","steps":["trace[946681603] 'agreement among raft nodes before linearized reading' (duration: 151.664418ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:22:40.536599Z","caller":"traceutil/trace.go:171","msg":"trace[1452985471] transaction","detail":"{read_only:false; response_revision:1391; number_of_response:1; }","duration":"100.292223ms","start":"2026-04-27T01:22:40.436272Z","end":"2026-04-27T01:22:40.536564Z","steps":["trace[1452985471] 'process raft request' (duration: 100.051077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:04.79992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.570006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-27T01:23:04.800064Z","caller":"traceutil/trace.go:171","msg":"trace[2083770602] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1800; }","duration":"238.76414ms","start":"2026-04-27T01:23:04.561272Z","end":"2026-04-27T01:23:04.800036Z","steps":["trace[2083770602] 'range keys from in-memory index tree' (duration: 238.32077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:04.79999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.571469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fa44a726-2440-48fb-bd77-359e81fc9f6e\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-04-27T01:23:04.800393Z","caller":"traceutil/trace.go:171","msg":"trace[1295699091] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fa44a726-2440-48fb-bd77-359e81fc9f6e; range_end:; response_count:1; response_revision:1800; }","duration":"305.007549ms","start":"2026-04-27T01:23:04.495332Z","end":"2026-04-27T01:23:04.80034Z","steps":["trace[1295699091] 'range keys from in-memory index tree' (duration: 304.458765ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:04.800412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.3809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-27T01:23:04.800496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:04.495309Z","time spent":"305.148381ms","remote":"127.0.0.1:59644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3767,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fa44a726-2440-48fb-bd77-359e81fc9f6e\" "} {"level":"info","ts":"2026-04-27T01:23:04.800516Z","caller":"traceutil/trace.go:171","msg":"trace[1961313951] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1800; }","duration":"242.544054ms","start":"2026-04-27T01:23:04.557948Z","end":"2026-04-27T01:23:04.800492Z","steps":["trace[1961313951] 'range keys from in-memory index tree' (duration: 242.165715ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:04.800784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.324445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-27T01:23:04.800751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.624876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T01:23:04.800867Z","caller":"traceutil/trace.go:171","msg":"trace[2115414832] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1800; }","duration":"134.45133ms","start":"2026-04-27T01:23:04.666397Z","end":"2026-04-27T01:23:04.800849Z","steps":["trace[2115414832] 'range keys from in-memory index tree' (duration: 134.176822ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:04.800901Z","caller":"traceutil/trace.go:171","msg":"trace[683830912] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1800; }","duration":"173.808372ms","start":"2026-04-27T01:23:04.627079Z","end":"2026-04-27T01:23:04.800888Z","steps":["trace[683830912] 'count revisions from in-memory index tree' (duration: 172.728956ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:04.801313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.739237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-27T01:23:04.801396Z","caller":"traceutil/trace.go:171","msg":"trace[1717048180] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1800; }","duration":"144.83608ms","start":"2026-04-27T01:23:04.65652Z","end":"2026-04-27T01:23:04.801356Z","steps":["trace[1717048180] 'range keys from in-memory index tree' (duration: 143.108811ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:16.026048Z","caller":"traceutil/trace.go:171","msg":"trace[1090288317] linearizableReadLoop","detail":"{readStateIndex:1976; appliedIndex:1975; }","duration":"131.589466ms","start":"2026-04-27T01:23:15.894431Z","end":"2026-04-27T01:23:16.02602Z","steps":["trace[1090288317] 'read index received' (duration: 131.508435ms)","trace[1090288317] 'applied index is now lower than readState.Index' (duration: 79.411µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:23:16.026294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.844021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-27T01:23:16.026344Z","caller":"traceutil/trace.go:171","msg":"trace[1012439460] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1900; }","duration":"131.951954ms","start":"2026-04-27T01:23:15.894379Z","end":"2026-04-27T01:23:16.026331Z","steps":["trace[1012439460] 'agreement among raft nodes before linearized reading' (duration: 131.7523ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:16.02666Z","caller":"traceutil/trace.go:171","msg":"trace[1127273447] transaction","detail":"{read_only:false; response_revision:1900; number_of_response:1; }","duration":"184.154787ms","start":"2026-04-27T01:23:15.842484Z","end":"2026-04-27T01:23:16.026639Z","steps":["trace[1127273447] 'process raft request' (duration: 183.33664ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:38.940219Z","caller":"traceutil/trace.go:171","msg":"trace[1041338021] transaction","detail":"{read_only:false; response_revision:2037; number_of_response:1; }","duration":"127.168072ms","start":"2026-04-27T01:23:38.813016Z","end":"2026-04-27T01:23:38.940184Z","steps":["trace[1041338021] 'process raft request' (duration: 126.915367ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:39.226085Z","caller":"traceutil/trace.go:171","msg":"trace[2044926788] transaction","detail":"{read_only:false; response_revision:2038; number_of_response:1; }","duration":"139.936771ms","start":"2026-04-27T01:23:39.086117Z","end":"2026-04-27T01:23:39.226053Z","steps":["trace[2044926788] 'process raft request' (duration: 139.717127ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:39.321535Z","caller":"traceutil/trace.go:171","msg":"trace[947789148] linearizableReadLoop","detail":"{readStateIndex:2120; appliedIndex:2118; }","duration":"228.294416ms","start":"2026-04-27T01:23:39.093214Z","end":"2026-04-27T01:23:39.321508Z","steps":["trace[947789148] 'read index received' (duration: 132.774796ms)","trace[947789148] 'applied index is now lower than readState.Index' (duration: 95.5183ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:23:39.321665Z","caller":"traceutil/trace.go:171","msg":"trace[1651178969] transaction","detail":"{read_only:false; response_revision:2039; number_of_response:1; }","duration":"233.925823ms","start":"2026-04-27T01:23:39.087727Z","end":"2026-04-27T01:23:39.321653Z","steps":["trace[1651178969] 'process raft request' (duration: 233.617168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:39.32189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.397818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-27T01:23:39.32204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.811775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-27T01:23:39.322063Z","caller":"traceutil/trace.go:171","msg":"trace[459380782] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2039; }","duration":"228.602302ms","start":"2026-04-27T01:23:39.093434Z","end":"2026-04-27T01:23:39.322037Z","steps":["trace[459380782] 'agreement among raft nodes before linearized reading' (duration: 228.259035ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:39.322082Z","caller":"traceutil/trace.go:171","msg":"trace[109041659] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2039; }","duration":"228.873766ms","start":"2026-04-27T01:23:39.093196Z","end":"2026-04-27T01:23:39.322069Z","steps":["trace[109041659] 'agreement among raft nodes before linearized reading' (duration: 228.762054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:39.322158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.842441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:39.322279Z","caller":"traceutil/trace.go:171","msg":"trace[271863930] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:2039; }","duration":"174.021525ms","start":"2026-04-27T01:23:39.148231Z","end":"2026-04-27T01:23:39.322253Z","steps":["trace[271863930] 'agreement among raft nodes before linearized reading' (duration: 173.725809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:53.823306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.998044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:23:53.823418Z","caller":"traceutil/trace.go:171","msg":"trace[1397089705] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2113; }","duration":"479.180957ms","start":"2026-04-27T01:23:53.344211Z","end":"2026-04-27T01:23:53.823392Z","steps":["trace[1397089705] 'range keys from in-memory index tree' (duration: 478.823042ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:53.823482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:53.34418Z","time spent":"479.288979ms","remote":"127.0.0.1:59436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-27T01:23:53.823453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.881225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-27T01:23:53.823563Z","caller":"traceutil/trace.go:171","msg":"trace[472446826] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2113; }","duration":"417.051098ms","start":"2026-04-27T01:23:53.406486Z","end":"2026-04-27T01:23:53.823538Z","steps":["trace[472446826] 'range keys from in-memory index tree' (duration: 416.52709ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:53.823651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:53.406457Z","time spent":"417.155399ms","remote":"127.0.0.1:59718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-27T01:23:53.82443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.028056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T01:23:53.824503Z","caller":"traceutil/trace.go:171","msg":"trace[167152096] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2113; }","duration":"420.139547ms","start":"2026-04-27T01:23:53.404346Z","end":"2026-04-27T01:23:53.824485Z","steps":["trace[167152096] 'range keys from in-memory index tree' (duration: 419.876692ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:53.824537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:53.404338Z","time spent":"420.192208ms","remote":"127.0.0.1:59718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-27T01:23:53.82463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.9133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-27T01:23:53.824685Z","caller":"traceutil/trace.go:171","msg":"trace[203200934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2113; }","duration":"421.052283ms","start":"2026-04-27T01:23:53.403618Z","end":"2026-04-27T01:23:53.82467Z","steps":["trace[203200934] 'range keys from in-memory index tree' (duration: 420.708047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:53.824469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.920212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-27T01:23:53.824766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:53.40359Z","time spent":"421.160604ms","remote":"127.0.0.1:59718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-27T01:23:53.824879Z","caller":"traceutil/trace.go:171","msg":"trace[1463369928] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2113; }","duration":"423.300829ms","start":"2026-04-27T01:23:53.401454Z","end":"2026-04-27T01:23:53.824755Z","steps":["trace[1463369928] 'range keys from in-memory index tree' (duration: 422.599956ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:23:53.825017Z","caller":"traceutil/trace.go:171","msg":"trace[1059777658] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"291.066742ms","start":"2026-04-27T01:23:53.533933Z","end":"2026-04-27T01:23:53.825Z","steps":["trace[1059777658] 'process raft request' (duration: 289.266273ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:23:53.825138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:53.401429Z","time spent":"423.554793ms","remote":"127.0.0.1:59718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-27T01:24:26.975578Z","caller":"traceutil/trace.go:171","msg":"trace[1648227137] linearizableReadLoop","detail":"{readStateIndex:2393; appliedIndex:2392; }","duration":"261.761556ms","start":"2026-04-27T01:24:26.713787Z","end":"2026-04-27T01:24:26.975549Z","steps":["trace[1648227137] 'read index received' (duration: 260.320116ms)","trace[1648227137] 'applied index is now lower than readState.Index' (duration: 1.43996ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:24:26.975773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.964198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T01:24:26.975833Z","caller":"traceutil/trace.go:171","msg":"trace[1395756160] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:2301; }","duration":"262.078101ms","start":"2026-04-27T01:24:26.713721Z","end":"2026-04-27T01:24:26.975799Z","steps":["trace[1395756160] 'agreement among raft nodes before linearized reading' (duration: 261.971289ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:24:26.975757Z","caller":"traceutil/trace.go:171","msg":"trace[1672902913] transaction","detail":"{read_only:false; response_revision:2301; number_of_response:1; }","duration":"312.122278ms","start":"2026-04-27T01:24:26.663566Z","end":"2026-04-27T01:24:26.975688Z","steps":["trace[1672902913] 'process raft request' (duration: 310.501766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:24:26.976836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:26.663539Z","time spent":"312.796689ms","remote":"127.0.0.1:59718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T01:24:27.618263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.021899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5460"} {"level":"info","ts":"2026-04-27T01:24:27.618338Z","caller":"traceutil/trace.go:171","msg":"trace[759147351] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2301; }","duration":"500.651398ms","start":"2026-04-27T01:24:27.117669Z","end":"2026-04-27T01:24:27.61832Z","steps":["trace[759147351] 'range keys from in-memory index tree' (duration: 499.839557ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:24:27.618371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:27.117643Z","time spent":"500.720129ms","remote":"127.0.0.1:59050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5483,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-27T01:24:28.180087Z","caller":"traceutil/trace.go:171","msg":"trace[800329700] transaction","detail":"{read_only:false; response_revision:2304; number_of_response:1; }","duration":"204.287846ms","start":"2026-04-27T01:24:27.975775Z","end":"2026-04-27T01:24:28.180063Z","steps":["trace[800329700] 'process raft request' (duration: 204.162484ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:24:28.180542Z","caller":"traceutil/trace.go:171","msg":"trace[993298030] linearizableReadLoop","detail":"{readStateIndex:2395; appliedIndex:2394; }","duration":"351.803379ms","start":"2026-04-27T01:24:27.828704Z","end":"2026-04-27T01:24:28.180507Z","steps":["trace[993298030] 'read index received' (duration: 345.422719ms)","trace[993298030] 'applied index is now lower than readState.Index' (duration: 6.37831ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:24:28.180647Z","caller":"traceutil/trace.go:171","msg":"trace[494951219] transaction","detail":"{read_only:false; response_revision:2303; number_of_response:1; }","duration":"557.34855ms","start":"2026-04-27T01:24:27.623248Z","end":"2026-04-27T01:24:28.180597Z","steps":["trace[494951219] 'process raft request' (duration: 550.865889ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:24:28.180862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:27.623224Z","time spent":"557.519212ms","remote":"127.0.0.1:59718","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-04-27T01:24:28.181086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.687994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-27T01:24:28.181146Z","caller":"traceutil/trace.go:171","msg":"trace[2059898953] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2304; }","duration":"164.771576ms","start":"2026-04-27T01:24:28.016361Z","end":"2026-04-27T01:24:28.181132Z","steps":["trace[2059898953] 'agreement among raft nodes before linearized reading' (duration: 164.569803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:24:28.181083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.383024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-27T01:24:28.181206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.45115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"} {"level":"info","ts":"2026-04-27T01:24:28.181262Z","caller":"traceutil/trace.go:171","msg":"trace[1510382589] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2304; }","duration":"152.629538ms","start":"2026-04-27T01:24:28.028619Z","end":"2026-04-27T01:24:28.181249Z","steps":["trace[1510382589] 'agreement among raft nodes before linearized reading' (duration: 152.253913ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:24:28.18129Z","caller":"traceutil/trace.go:171","msg":"trace[322259460] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2304; }","duration":"161.554931ms","start":"2026-04-27T01:24:28.019713Z","end":"2026-04-27T01:24:28.181268Z","steps":["trace[322259460] 'agreement among raft nodes before linearized reading' (duration: 161.215326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:24:28.181438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.949128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-27T01:24:28.181491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.790297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-27T01:24:28.181766Z","caller":"traceutil/trace.go:171","msg":"trace[474670327] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2304; }","duration":"147.085671ms","start":"2026-04-27T01:24:28.034663Z","end":"2026-04-27T01:24:28.181749Z","steps":["trace[474670327] 'agreement among raft nodes before linearized reading' (duration: 146.762916ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:24:28.18214Z","caller":"traceutil/trace.go:171","msg":"trace[480214187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2304; }","duration":"165.272872ms","start":"2026-04-27T01:24:28.016315Z","end":"2026-04-27T01:24:28.181588Z","steps":["trace[480214187] 'agreement among raft nodes before linearized reading' (duration: 164.531462ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:24:28.182178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.460841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:11625"} {"level":"info","ts":"2026-04-27T01:24:28.182457Z","caller":"traceutil/trace.go:171","msg":"trace[2057305266] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:2304; }","duration":"353.782036ms","start":"2026-04-27T01:24:27.82866Z","end":"2026-04-27T01:24:28.182442Z","steps":["trace[2057305266] 'agreement among raft nodes before linearized reading' (duration: 352.020192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:24:28.182494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:27.828638Z","time spent":"353.844406ms","remote":"127.0.0.1:59644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":11648,"request content":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" "} {"level":"warn","ts":"2026-04-27T01:25:16.096428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.489032ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-27T01:25:16.096583Z","caller":"traceutil/trace.go:171","msg":"trace[470439551] linearizableReadLoop","detail":"{readStateIndex:2765; appliedIndex:2764; }","duration":"121.324469ms","start":"2026-04-27T01:25:15.975233Z","end":"2026-04-27T01:25:16.096557Z","steps":["trace[470439551] 'read index received' (duration: 85.661µs)","trace[470439551] 'applied index is now lower than readState.Index' (duration: 121.236888ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:25:16.096787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.547582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1366"} {"level":"info","ts":"2026-04-27T01:25:16.096825Z","caller":"traceutil/trace.go:171","msg":"trace[1334987846] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2661; }","duration":"121.641263ms","start":"2026-04-27T01:25:15.975171Z","end":"2026-04-27T01:25:16.096812Z","steps":["trace[1334987846] 'agreement among raft nodes before linearized reading' (duration: 121.452111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:27.169008Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356764990663875183,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T01:25:27.790461Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356764990663875183,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T01:25:27.79564Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.123681017s","expected-duration":"1s"} {"level":"info","ts":"2026-04-27T01:25:27.796082Z","caller":"traceutil/trace.go:171","msg":"trace[641327689] linearizableReadLoop","detail":"{readStateIndex:2823; appliedIndex:2822; }","duration":"1.127778197s","start":"2026-04-27T01:25:26.668259Z","end":"2026-04-27T01:25:27.796037Z","steps":["trace[641327689] 'read index received' (duration: 1.127494972s)","trace[641327689] 'applied index is now lower than readState.Index' (duration: 282.565µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:25:27.796245Z","caller":"traceutil/trace.go:171","msg":"trace[914081388] transaction","detail":"{read_only:false; response_revision:2717; number_of_response:1; }","duration":"1.152709487s","start":"2026-04-27T01:25:26.643527Z","end":"2026-04-27T01:25:27.796237Z","steps":["trace[914081388] 'process raft request' (duration: 1.152272742s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:27.796407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:25:26.64351Z","time spent":"1.152755608s","remote":"127.0.0.1:59718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T01:25:27.796608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.128358553s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-04-27T01:25:27.796675Z","caller":"traceutil/trace.go:171","msg":"trace[1236825970] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2717; }","duration":"1.128456535s","start":"2026-04-27T01:25:26.668209Z","end":"2026-04-27T01:25:27.796665Z","steps":["trace[1236825970] 'agreement among raft nodes before linearized reading' (duration: 1.128305813s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:27.796743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:25:26.668194Z","time spent":"1.128543356s","remote":"127.0.0.1:59718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":594,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-04-27T01:25:27.7969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.123800068s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-27T01:25:27.79692Z","caller":"traceutil/trace.go:171","msg":"trace[1367574607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2717; }","duration":"1.123831108s","start":"2026-04-27T01:25:26.673084Z","end":"2026-04-27T01:25:27.796916Z","steps":["trace[1367574607] 'agreement among raft nodes before linearized reading' (duration: 1.123772257s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:27.796936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:25:26.673079Z","time spent":"1.123852128s","remote":"127.0.0.1:59718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-27T01:25:27.79715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.739684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T01:25:27.797173Z","caller":"traceutil/trace.go:171","msg":"trace[1619075419] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2717; }","duration":"417.817364ms","start":"2026-04-27T01:25:27.37935Z","end":"2026-04-27T01:25:27.797167Z","steps":["trace[1619075419] 'agreement among raft nodes before linearized reading' (duration: 417.777013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:27.797188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:25:27.379318Z","time spent":"417.866485ms","remote":"127.0.0.1:59006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-04-27T01:25:27.797283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.939317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18aa124568a5d252\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-04-27T01:25:27.797302Z","caller":"traceutil/trace.go:171","msg":"trace[1153853605] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18aa124568a5d252; range_end:; response_count:1; response_revision:2717; }","duration":"526.016228ms","start":"2026-04-27T01:25:27.271281Z","end":"2026-04-27T01:25:27.797297Z","steps":["trace[1153853605] 'agreement among raft nodes before linearized reading' (duration: 525.959988ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:27.797315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:25:27.271245Z","time spent":"526.066509ms","remote":"127.0.0.1:59522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":802,"request content":"key:\"/registry/events/auth-system/keycloak-0.18aa124568a5d252\" "} {"level":"warn","ts":"2026-04-27T01:25:27.797456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"778.051565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-04-27T01:25:27.797475Z","caller":"traceutil/trace.go:171","msg":"trace[1472949050] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2717; }","duration":"778.093006ms","start":"2026-04-27T01:25:27.019378Z","end":"2026-04-27T01:25:27.797471Z","steps":["trace[1472949050] 'agreement among raft nodes before linearized reading' (duration: 778.025366ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:27.797553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:25:27.019367Z","time spent":"778.180227ms","remote":"127.0.0.1:59718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-04-27T01:25:27.797667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.150983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T01:25:27.797686Z","caller":"traceutil/trace.go:171","msg":"trace[1418561604] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:2717; }","duration":"815.205074ms","start":"2026-04-27T01:25:26.982477Z","end":"2026-04-27T01:25:27.797682Z","steps":["trace[1418561604] 'agreement among raft nodes before linearized reading' (duration: 815.155203ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:27.797701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:25:26.982463Z","time spent":"815.234964ms","remote":"127.0.0.1:59656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":21,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-04-27T01:25:27.797825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"945.254983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-27T01:25:27.797862Z","caller":"traceutil/trace.go:171","msg":"trace[1255016014] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2717; }","duration":"945.332424ms","start":"2026-04-27T01:25:26.852524Z","end":"2026-04-27T01:25:27.797857Z","steps":["trace[1255016014] 'agreement among raft nodes before linearized reading' (duration: 945.263143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:27.797877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:25:26.852504Z","time spent":"945.369274ms","remote":"127.0.0.1:59718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-27T01:25:27.797988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.122734725s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-27T01:25:27.798022Z","caller":"traceutil/trace.go:171","msg":"trace[1443490863] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2717; }","duration":"1.122780446s","start":"2026-04-27T01:25:26.675237Z","end":"2026-04-27T01:25:27.798018Z","steps":["trace[1443490863] 'agreement among raft nodes before linearized reading' (duration: 1.122718075s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:25:27.798037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:25:26.675232Z","time spent":"1.122801506s","remote":"127.0.0.1:59718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-27T01:25:27.979477Z","caller":"traceutil/trace.go:171","msg":"trace[255085513] transaction","detail":"{read_only:false; response_revision:2720; number_of_response:1; }","duration":"174.782476ms","start":"2026-04-27T01:25:27.804649Z","end":"2026-04-27T01:25:27.979432Z","steps":["trace[255085513] 'process raft request' (duration: 174.23651ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:25:27.979602Z","caller":"traceutil/trace.go:171","msg":"trace[1916395201] transaction","detail":"{read_only:false; response_revision:2723; number_of_response:1; }","duration":"173.508051ms","start":"2026-04-27T01:25:27.806052Z","end":"2026-04-27T01:25:27.97956Z","steps":["trace[1916395201] 'process raft request' (duration: 173.397149ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:25:27.979534Z","caller":"traceutil/trace.go:171","msg":"trace[1103279023] transaction","detail":"{read_only:false; response_revision:2721; number_of_response:1; }","duration":"173.725344ms","start":"2026-04-27T01:25:27.805772Z","end":"2026-04-27T01:25:27.979497Z","steps":["trace[1103279023] 'process raft request' (duration: 173.526912ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:25:27.979897Z","caller":"traceutil/trace.go:171","msg":"trace[1712627716] transaction","detail":"{read_only:false; response_revision:2722; number_of_response:1; }","duration":"174.032597ms","start":"2026-04-27T01:25:27.80585Z","end":"2026-04-27T01:25:27.979882Z","steps":["trace[1712627716] 'process raft request' (duration: 173.561812ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:25:28.679046Z","caller":"traceutil/trace.go:171","msg":"trace[1745163267] transaction","detail":"{read_only:false; response_revision:2728; number_of_response:1; }","duration":"148.381026ms","start":"2026-04-27T01:25:28.530624Z","end":"2026-04-27T01:25:28.679005Z","steps":["trace[1745163267] 'process raft request' (duration: 78.532075ms)","trace[1745163267] 'compare' (duration: 69.590758ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:29:16.115167Z","caller":"traceutil/trace.go:171","msg":"trace[1607617506] transaction","detail":"{read_only:false; response_revision:4614; number_of_response:1; }","duration":"156.800387ms","start":"2026-04-27T01:29:15.958316Z","end":"2026-04-27T01:29:16.115116Z","steps":["trace[1607617506] 'process raft request' (duration: 102.205802ms)","trace[1607617506] 'compare' (duration: 54.332641ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:29:22.303703Z","caller":"traceutil/trace.go:171","msg":"trace[325241810] linearizableReadLoop","detail":"{readStateIndex:4903; appliedIndex:4902; }","duration":"184.995061ms","start":"2026-04-27T01:29:22.11868Z","end":"2026-04-27T01:29:22.303675Z","steps":["trace[325241810] 'read index received' (duration: 184.723646ms)","trace[325241810] 'applied index is now lower than readState.Index' (duration: 270.355µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:29:22.304332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.610612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"warn","ts":"2026-04-27T01:29:22.304334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.825363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T01:29:22.304471Z","caller":"traceutil/trace.go:171","msg":"trace[1110916909] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4717; }","duration":"185.766536ms","start":"2026-04-27T01:29:22.118654Z","end":"2026-04-27T01:29:22.304421Z","steps":["trace[1110916909] 'agreement among raft nodes before linearized reading' (duration: 185.511921ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:29:22.304552Z","caller":"traceutil/trace.go:171","msg":"trace[225920471] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4717; }","duration":"166.975578ms","start":"2026-04-27T01:29:22.137455Z","end":"2026-04-27T01:29:22.30443Z","steps":["trace[225920471] 'agreement among raft nodes before linearized reading' (duration: 166.679931ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:29:22.304236Z","caller":"traceutil/trace.go:171","msg":"trace[2101886222] transaction","detail":"{read_only:false; response_revision:4717; number_of_response:1; }","duration":"189.225409ms","start":"2026-04-27T01:29:22.114956Z","end":"2026-04-27T01:29:22.304182Z","steps":["trace[2101886222] 'process raft request' (duration: 188.511976ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:29:22.527237Z","caller":"traceutil/trace.go:171","msg":"trace[193869077] transaction","detail":"{read_only:false; response_revision:4718; number_of_response:1; }","duration":"216.642837ms","start":"2026-04-27T01:29:22.310563Z","end":"2026-04-27T01:29:22.527205Z","steps":["trace[193869077] 'process raft request' (duration: 162.006905ms)","trace[193869077] 'compare' (duration: 54.435989ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:29:22.52745Z","caller":"traceutil/trace.go:171","msg":"trace[1794216532] linearizableReadLoop","detail":"{readStateIndex:4905; appliedIndex:4903; }","duration":"216.138578ms","start":"2026-04-27T01:29:22.311281Z","end":"2026-04-27T01:29:22.527419Z","steps":["trace[1794216532] 'read index received' (duration: 161.277442ms)","trace[1794216532] 'applied index is now lower than readState.Index' (duration: 54.859126ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:29:22.527997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.041487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:61027"} {"level":"info","ts":"2026-04-27T01:29:22.528056Z","caller":"traceutil/trace.go:171","msg":"trace[1040385388] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4718; }","duration":"216.138629ms","start":"2026-04-27T01:29:22.311903Z","end":"2026-04-27T01:29:22.528041Z","steps":["trace[1040385388] 'agreement among raft nodes before linearized reading' (duration: 215.835363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:29:22.528277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.951813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-04-27T01:29:22.528466Z","caller":"traceutil/trace.go:171","msg":"trace[318304192] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4718; }","duration":"217.179478ms","start":"2026-04-27T01:29:22.311252Z","end":"2026-04-27T01:29:22.528432Z","steps":["trace[318304192] 'agreement among raft nodes before linearized reading' (duration: 216.702139ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:29:22.665546Z","caller":"traceutil/trace.go:171","msg":"trace[951464136] transaction","detail":"{read_only:false; response_revision:4720; number_of_response:1; }","duration":"116.126793ms","start":"2026-04-27T01:29:22.549385Z","end":"2026-04-27T01:29:22.665511Z","steps":["trace[951464136] 'process raft request' (duration: 102.470961ms)","trace[951464136] 'compare' (duration: 13.335146ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:29:22.914254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.890725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2348486"} {"level":"info","ts":"2026-04-27T01:29:22.914339Z","caller":"traceutil/trace.go:171","msg":"trace[2031424928] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4722; }","duration":"105.030318ms","start":"2026-04-27T01:29:22.809288Z","end":"2026-04-27T01:29:22.914318Z","steps":["trace[2031424928] 'range keys from in-memory index tree' (duration: 103.991379ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:29:23.619151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.072737ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T01:29:23.619384Z","caller":"traceutil/trace.go:171","msg":"trace[1698597405] transaction","detail":"{read_only:false; response_revision:4727; number_of_response:1; }","duration":"620.468986ms","start":"2026-04-27T01:29:22.998865Z","end":"2026-04-27T01:29:23.619334Z","steps":["trace[1698597405] 'process raft request' (duration: 281.104305ms)","trace[1698597405] 'compare' (duration: 338.74218ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:29:23.619528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:29:22.998845Z","time spent":"620.592978ms","remote":"127.0.0.1:59622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":850,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T01:29:23.620289Z","caller":"traceutil/trace.go:171","msg":"trace[396597010] transaction","detail":"{read_only:false; response_revision:4728; number_of_response:1; }","duration":"621.336851ms","start":"2026-04-27T01:29:22.998931Z","end":"2026-04-27T01:29:23.620268Z","steps":["trace[396597010] 'process raft request' (duration: 620.358253ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:29:23.620401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:29:22.998926Z","time spent":"621.414212ms","remote":"127.0.0.1:59622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1273,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T01:29:23.621033Z","caller":"traceutil/trace.go:171","msg":"trace[1429813354] linearizableReadLoop","detail":"{readStateIndex:4915; appliedIndex:4912; }","duration":"621.987304ms","start":"2026-04-27T01:29:22.999026Z","end":"2026-04-27T01:29:23.621013Z","steps":["trace[1429813354] 'read index received' (duration: 47.754105ms)","trace[1429813354] 'applied index is now lower than readState.Index' (duration: 574.230469ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:29:23.621295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.259399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12973"} {"level":"info","ts":"2026-04-27T01:29:23.621101Z","caller":"traceutil/trace.go:171","msg":"trace[385171420] transaction","detail":"{read_only:false; response_revision:4729; number_of_response:1; }","duration":"619.530797ms","start":"2026-04-27T01:29:23.001357Z","end":"2026-04-27T01:29:23.620888Z","steps":["trace[385171420] 'process raft request' (duration: 618.785384ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:29:23.621348Z","caller":"traceutil/trace.go:171","msg":"trace[1135322792] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4729; }","duration":"622.34793ms","start":"2026-04-27T01:29:22.998987Z","end":"2026-04-27T01:29:23.621335Z","steps":["trace[1135322792] 'agreement among raft nodes before linearized reading' (duration: 622.151277ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:29:23.621393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:29:22.998969Z","time spent":"622.415292ms","remote":"127.0.0.1:59644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":12996,"request content":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-04-27T01:29:23.621743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:29:23.001341Z","time spent":"620.236831ms","remote":"127.0.0.1:59726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1853,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T01:29:23.621951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.873001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-24d6fd8f-b7b0-42ac-b7ce-b4f1cadc7b55\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-04-27T01:29:23.622004Z","caller":"traceutil/trace.go:171","msg":"trace[1798970136] range","detail":"{range_begin:/registry/persistentvolumes/pvc-24d6fd8f-b7b0-42ac-b7ce-b4f1cadc7b55; range_end:; response_count:1; response_revision:4731; }","duration":"622.925751ms","start":"2026-04-27T01:29:22.999066Z","end":"2026-04-27T01:29:23.621991Z","steps":["trace[1798970136] 'agreement among raft nodes before linearized reading' (duration: 622.793989ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:29:23.622035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:29:22.999031Z","time spent":"622.996543ms","remote":"127.0.0.1:59592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1458,"request content":"key:\"/registry/persistentvolumes/pvc-24d6fd8f-b7b0-42ac-b7ce-b4f1cadc7b55\" "} {"level":"warn","ts":"2026-04-27T01:29:23.622175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.986047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-04-27T01:29:23.62221Z","caller":"traceutil/trace.go:171","msg":"trace[371405131] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4731; }","duration":"338.055937ms","start":"2026-04-27T01:29:23.284144Z","end":"2026-04-27T01:29:23.6222Z","steps":["trace[371405131] 'agreement among raft nodes before linearized reading' (duration: 337.969616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:29:23.622238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:29:23.284124Z","time spent":"338.106649ms","remote":"127.0.0.1:59718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":594,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-04-27T01:29:23.622453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.985668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-27T01:29:23.622263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.796721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:29:23.622495Z","caller":"traceutil/trace.go:171","msg":"trace[1517970241] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4731; }","duration":"323.036889ms","start":"2026-04-27T01:29:23.299447Z","end":"2026-04-27T01:29:23.622484Z","steps":["trace[1517970241] 'agreement among raft nodes before linearized reading' (duration: 322.942998ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:29:23.622524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:29:23.29944Z","time spent":"323.07736ms","remote":"127.0.0.1:59718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-27T01:29:23.62253Z","caller":"traceutil/trace.go:171","msg":"trace[673729517] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4731; }","duration":"278.114278ms","start":"2026-04-27T01:29:23.344388Z","end":"2026-04-27T01:29:23.622502Z","steps":["trace[673729517] 'agreement among raft nodes before linearized reading' (duration: 277.70116ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:29:23.622703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.363868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-27T01:29:23.62274Z","caller":"traceutil/trace.go:171","msg":"trace[762688035] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4731; }","duration":"334.45147ms","start":"2026-04-27T01:29:23.28828Z","end":"2026-04-27T01:29:23.622731Z","steps":["trace[762688035] 'agreement among raft nodes before linearized reading' (duration: 334.364468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:29:23.622774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:29:23.288266Z","time spent":"334.501442ms","remote":"127.0.0.1:59718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-27T01:29:23.623015Z","caller":"traceutil/trace.go:171","msg":"trace[899156812] transaction","detail":"{read_only:false; response_revision:4730; number_of_response:1; }","duration":"379.603546ms","start":"2026-04-27T01:29:23.243392Z","end":"2026-04-27T01:29:23.622995Z","steps":["trace[899156812] 'process raft request' (duration: 377.431985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:29:23.623097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.9188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3465"} {"level":"info","ts":"2026-04-27T01:29:23.623138Z","caller":"traceutil/trace.go:171","msg":"trace[546683640] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4731; }","duration":"608.983452ms","start":"2026-04-27T01:29:23.014143Z","end":"2026-04-27T01:29:23.623126Z","steps":["trace[546683640] 'agreement among raft nodes before linearized reading' (duration: 608.87279ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:29:23.623166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:29:23.014131Z","time spent":"609.028863ms","remote":"127.0.0.1:59532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":3488,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" "} {"level":"warn","ts":"2026-04-27T01:29:23.62316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:29:23.24336Z","time spent":"379.705418ms","remote":"127.0.0.1:59522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":922,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T01:29:23.623358Z","caller":"traceutil/trace.go:171","msg":"trace[1757965769] transaction","detail":"{read_only:false; response_revision:4731; number_of_response:1; }","duration":"250.424295ms","start":"2026-04-27T01:29:23.372926Z","end":"2026-04-27T01:29:23.62335Z","steps":["trace[1757965769] 'process raft request' (duration: 248.869727ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:29:23.624007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.929797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-27T01:29:23.624364Z","caller":"traceutil/trace.go:171","msg":"trace[1323774961] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4731; }","duration":"586.038159ms","start":"2026-04-27T01:29:23.038209Z","end":"2026-04-27T01:29:23.624247Z","steps":["trace[1323774961] 'agreement among raft nodes before linearized reading' (duration: 584.794015ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:29:23.624573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:29:23.038191Z","time spent":"586.259862ms","remote":"127.0.0.1:59718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-27T01:29:28.243739Z","caller":"traceutil/trace.go:171","msg":"trace[291152882] linearizableReadLoop","detail":"{readStateIndex:5008; appliedIndex:5007; }","duration":"110.327943ms","start":"2026-04-27T01:29:28.13338Z","end":"2026-04-27T01:29:28.243708Z","steps":["trace[291152882] 'read index received' (duration: 84.250154ms)","trace[291152882] 'applied index is now lower than readState.Index' (duration: 26.076699ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:29:28.243915Z","caller":"traceutil/trace.go:171","msg":"trace[1398873704] transaction","detail":"{read_only:false; response_revision:4817; number_of_response:1; }","duration":"112.818628ms","start":"2026-04-27T01:29:28.131084Z","end":"2026-04-27T01:29:28.243903Z","steps":["trace[1398873704] 'process raft request' (duration: 86.607627ms)","trace[1398873704] 'compare' (duration: 25.779604ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:29:28.244052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.120852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3465"} {"level":"info","ts":"2026-04-27T01:29:28.244107Z","caller":"traceutil/trace.go:171","msg":"trace[485065558] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4817; }","duration":"102.202634ms","start":"2026-04-27T01:29:28.141891Z","end":"2026-04-27T01:29:28.244093Z","steps":["trace[485065558] 'agreement among raft nodes before linearized reading' (duration: 102.049121ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:29:28.244173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.791511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:2643"} {"level":"info","ts":"2026-04-27T01:29:28.244197Z","caller":"traceutil/trace.go:171","msg":"trace[141479311] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4817; }","duration":"110.826522ms","start":"2026-04-27T01:29:28.133363Z","end":"2026-04-27T01:29:28.24419Z","steps":["trace[141479311] 'agreement among raft nodes before linearized reading' (duration: 110.770111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:29:28.244261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.871679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4867"} {"level":"info","ts":"2026-04-27T01:29:28.244284Z","caller":"traceutil/trace.go:171","msg":"trace[234075427] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4817; }","duration":"100.905019ms","start":"2026-04-27T01:29:28.14337Z","end":"2026-04-27T01:29:28.244275Z","steps":["trace[234075427] 'agreement among raft nodes before linearized reading' (duration: 100.847058ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:29:35.143144Z","caller":"traceutil/trace.go:171","msg":"trace[969548683] transaction","detail":"{read_only:false; response_revision:4896; number_of_response:1; }","duration":"136.398977ms","start":"2026-04-27T01:29:35.006711Z","end":"2026-04-27T01:29:35.14311Z","steps":["trace[969548683] 'process raft request' (duration: 136.158101ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:29:35.15883Z","caller":"traceutil/trace.go:171","msg":"trace[958615238] transaction","detail":"{read_only:false; response_revision:4897; number_of_response:1; }","duration":"120.648881ms","start":"2026-04-27T01:29:35.038155Z","end":"2026-04-27T01:29:35.158804Z","steps":["trace[958615238] 'process raft request' (duration: 120.498768ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:30:47.067528Z","caller":"traceutil/trace.go:171","msg":"trace[1498434085] transaction","detail":"{read_only:false; response_revision:5498; number_of_response:1; }","duration":"120.826177ms","start":"2026-04-27T01:30:46.946669Z","end":"2026-04-27T01:30:47.067496Z","steps":["trace[1498434085] 'process raft request' (duration: 120.602283ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:30:57.864538Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2876} {"level":"info","ts":"2026-04-27T01:30:57.942492Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2876,"took":"76.698457ms","hash":3150580371,"current-db-size-bytes":53436416,"current-db-size":"53 MB","current-db-size-in-use-bytes":29782016,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-27T01:30:57.942549Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3150580371,"revision":2876,"compact-revision":-1} {"level":"info","ts":"2026-04-27T01:33:08.896751Z","caller":"traceutil/trace.go:171","msg":"trace[240660705] linearizableReadLoop","detail":"{readStateIndex:6709; appliedIndex:6708; }","duration":"101.354252ms","start":"2026-04-27T01:33:08.795372Z","end":"2026-04-27T01:33:08.896726Z","steps":["trace[240660705] 'read index received' (duration: 101.107079ms)","trace[240660705] 'applied index is now lower than readState.Index' (duration: 246.183µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:33:08.896901Z","caller":"traceutil/trace.go:171","msg":"trace[451713993] transaction","detail":"{read_only:false; response_revision:6466; number_of_response:1; }","duration":"141.044378ms","start":"2026-04-27T01:33:08.755847Z","end":"2026-04-27T01:33:08.896891Z","steps":["trace[451713993] 'process raft request' (duration: 140.724744ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:33:08.897274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.882459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-27T01:33:08.897332Z","caller":"traceutil/trace.go:171","msg":"trace[11653401] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6466; }","duration":"101.989202ms","start":"2026-04-27T01:33:08.795333Z","end":"2026-04-27T01:33:08.897322Z","steps":["trace[11653401] 'agreement among raft nodes before linearized reading' (duration: 101.744658ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:33:08.897605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.178341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-27T01:33:08.897686Z","caller":"traceutil/trace.go:171","msg":"trace[1441646999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6466; }","duration":"101.282192ms","start":"2026-04-27T01:33:08.796386Z","end":"2026-04-27T01:33:08.897668Z","steps":["trace[1441646999] 'agreement among raft nodes before linearized reading' (duration: 101.084589ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:35:57.869309Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5600} {"level":"info","ts":"2026-04-27T01:35:57.94057Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5600,"took":"70.04506ms","hash":1408466823,"current-db-size-bytes":53436416,"current-db-size":"53 MB","current-db-size-in-use-bytes":18288640,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-27T01:35:57.940625Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1408466823,"revision":5600,"compact-revision":2876}