{"level":"warn","ts":"2026-09-12T04:00:36.20518Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-12T04:00:36.205362Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.140:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.140:2380","--initial-cluster=instance=https://162.253.55.140:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.140:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.140:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-12T04:00:36.205489Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-12T04:00:36.205508Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.140:2380"]} {"level":"info","ts":"2026-09-12T04:00:36.205544Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-12T04:00:36.207264Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"]} {"level":"info","ts":"2026-09-12T04:00:36.207449Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.140:2380"],"listen-peer-urls":["https://162.253.55.140:2380"],"advertise-client-urls":["https://162.253.55.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.140:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-12T04:00:36.212935Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.127517ms"} {"level":"info","ts":"2026-09-12T04:00:36.224137Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf809824ab95ac81","cluster-id":"6f89f5fbef18dc61"} {"level":"info","ts":"2026-09-12T04:00:36.224259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=()"} {"level":"info","ts":"2026-09-12T04:00:36.224287Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 0"} {"level":"info","ts":"2026-09-12T04:00:36.2243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf809824ab95ac81 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-12T04:00:36.224309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 1"} {"level":"info","ts":"2026-09-12T04:00:36.224358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"} {"level":"warn","ts":"2026-09-12T04:00:36.237109Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-12T04:00:36.239345Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-12T04:00:36.241426Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-12T04:00:36.251678Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf809824ab95ac81","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-12T04:00:36.25732Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf809824ab95ac81","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-12T04:00:36.257583Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-12T04:00:36.257702Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-12T04:00:36.257726Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-12T04:00:36.257993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"} {"level":"info","ts":"2026-09-12T04:00:36.258163Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6f89f5fbef18dc61","local-member-id":"cf809824ab95ac81","added-peer-id":"cf809824ab95ac81","added-peer-peer-urls":["https://162.253.55.140:2380"]} {"level":"info","ts":"2026-09-12T04:00:36.260555Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-12T04:00:36.260874Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf809824ab95ac81","initial-advertise-peer-urls":["https://162.253.55.140:2380"],"listen-peer-urls":["https://162.253.55.140:2380"],"advertise-client-urls":["https://162.253.55.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-12T04:00:36.260848Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.140:2380"} {"level":"info","ts":"2026-09-12T04:00:36.26093Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-12T04:00:36.26097Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.140:2380"} {"level":"info","ts":"2026-09-12T04:00:36.625619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 is starting a new election at term 1"} {"level":"info","ts":"2026-09-12T04:00:36.625828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-12T04:00:36.625846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgPreVoteResp from cf809824ab95ac81 at term 1"} {"level":"info","ts":"2026-09-12T04:00:36.625869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became candidate at term 2"} {"level":"info","ts":"2026-09-12T04:00:36.625876Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgVoteResp from cf809824ab95ac81 at term 2"} {"level":"info","ts":"2026-09-12T04:00:36.625886Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became leader at term 2"} {"level":"info","ts":"2026-09-12T04:00:36.625905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf809824ab95ac81 elected leader cf809824ab95ac81 at term 2"} {"level":"info","ts":"2026-09-12T04:00:36.691948Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T04:00:36.691979Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf809824ab95ac81","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.140:2379]}","request-path":"/0/members/cf809824ab95ac81/attributes","cluster-id":"6f89f5fbef18dc61","publish-timeout":"7s"} {"level":"info","ts":"2026-09-12T04:00:36.692122Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-12T04:00:36.692178Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-12T04:00:36.692546Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-12T04:00:36.692633Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-12T04:00:36.695633Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-12T04:00:36.695894Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.140:2379"} {"level":"info","ts":"2026-09-12T04:00:36.724809Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6f89f5fbef18dc61","local-member-id":"cf809824ab95ac81","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T04:00:36.725803Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T04:00:36.72586Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} 2026/09/12 04:00:42 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-09-12T04:00:42.391717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.070078ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T04:00:42.391821Z","caller":"traceutil/trace.go:171","msg":"trace[1995795837] linearizableReadLoop","detail":"{readStateIndex:262; appliedIndex:261; }","duration":"533.286379ms","start":"2026-09-12T04:00:41.858522Z","end":"2026-09-12T04:00:42.391809Z","steps":["trace[1995795837] 'read index received' (duration: 164.534379ms)","trace[1995795837] 'applied index is now lower than readState.Index' (duration: 368.75122ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T04:00:42.391907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.392422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T04:00:42.391937Z","caller":"traceutil/trace.go:171","msg":"trace[1102930198] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:0; response_revision:256; }","duration":"533.449035ms","start":"2026-09-12T04:00:41.85847Z","end":"2026-09-12T04:00:42.391919Z","steps":["trace[1102930198] 'agreement among raft nodes before linearized reading' (duration: 533.397573ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:00:42.39196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:00:41.858448Z","time spent":"533.506886ms","remote":"127.0.0.1:36436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"warn","ts":"2026-09-12T04:00:42.892427Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430393003065442921,"retry-timeout":"500ms"} {"level":"info","ts":"2026-09-12T04:00:42.951997Z","caller":"traceutil/trace.go:171","msg":"trace[814998364] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"760.919072ms","start":"2026-09-12T04:00:42.191057Z","end":"2026-09-12T04:00:42.951976Z","steps":["trace[814998364] 'process raft request' (duration: 738.4218ms)","trace[814998364] 'compare' (duration: 22.209143ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T04:00:42.952109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:00:42.191024Z","time spent":"761.024445ms","remote":"127.0.0.1:36298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-12T04:00:43.023534Z","caller":"traceutil/trace.go:171","msg":"trace[297859491] transaction","detail":"{read_only:false; number_of_response:0; response_revision:257; }","duration":"708.093002ms","start":"2026-09-12T04:00:42.315419Z","end":"2026-09-12T04:00:43.023512Z","steps":["trace[297859491] 'process raft request' (duration: 708.004349ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:00:43.023582Z","caller":"traceutil/trace.go:171","msg":"trace[976419649] linearizableReadLoop","detail":"{readStateIndex:269; appliedIndex:262; }","duration":"631.717427ms","start":"2026-09-12T04:00:42.391847Z","end":"2026-09-12T04:00:43.023565Z","steps":["trace[976419649] 'read index received' (duration: 537.710708ms)","trace[976419649] 'applied index is now lower than readState.Index' (duration: 94.005639ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:00:43.023651Z","caller":"traceutil/trace.go:171","msg":"trace[1469276907] transaction","detail":"{read_only:false; number_of_response:0; response_revision:257; }","duration":"708.134303ms","start":"2026-09-12T04:00:42.315511Z","end":"2026-09-12T04:00:43.023645Z","steps":["trace[1469276907] 'process raft request' (duration: 707.948047ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:00:43.023653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:00:42.315375Z","time spent":"708.227106ms","remote":"127.0.0.1:36416","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-12T04:00:43.023894Z","caller":"traceutil/trace.go:171","msg":"trace[1884267981] transaction","detail":"{read_only:false; number_of_response:0; response_revision:257; }","duration":"725.547442ms","start":"2026-09-12T04:00:42.298336Z","end":"2026-09-12T04:00:43.023883Z","steps":["trace[1884267981] 'process raft request' (duration: 725.008534ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:00:43.023934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:00:42.298302Z","time spent":"725.614834ms","remote":"127.0.0.1:36408","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-12T04:00:43.024115Z","caller":"traceutil/trace.go:171","msg":"trace[655162270] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"708.262279ms","start":"2026-09-12T04:00:42.315812Z","end":"2026-09-12T04:00:43.024074Z","steps":["trace[655162270] 'process raft request' (duration: 707.728791ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:00:43.02416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.261346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-09-12T04:00:43.024186Z","caller":"traceutil/trace.go:171","msg":"trace[1829539954] transaction","detail":"{read_only:false; number_of_response:0; response_revision:257; }","duration":"708.576958ms","start":"2026-09-12T04:00:42.315603Z","end":"2026-09-12T04:00:43.02418Z","steps":["trace[1829539954] 'process raft request' (duration: 707.870175ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:00:43.024219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:00:42.315598Z","time spent":"708.605649ms","remote":"127.0.0.1:36416","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-12T04:00:43.024189Z","caller":"traceutil/trace.go:171","msg":"trace[752101895] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:259; }","duration":"833.337888ms","start":"2026-09-12T04:00:42.190843Z","end":"2026-09-12T04:00:43.024181Z","steps":["trace[752101895] 'agreement among raft nodes before linearized reading' (duration: 833.263766ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:00:43.0243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:00:42.190819Z","time spent":"833.473193ms","remote":"127.0.0.1:36620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-09-12T04:00:43.024464Z","caller":"traceutil/trace.go:171","msg":"trace[374020675] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"708.703792ms","start":"2026-09-12T04:00:42.315752Z","end":"2026-09-12T04:00:43.024456Z","steps":["trace[374020675] 'process raft request' (duration: 707.73776ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:00:43.024503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:00:42.315747Z","time spent":"708.739714ms","remote":"127.0.0.1:36416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-12T04:00:43.024663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.653599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T04:00:43.024704Z","caller":"traceutil/trace.go:171","msg":"trace[992680343] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:259; }","duration":"829.731091ms","start":"2026-09-12T04:00:42.194966Z","end":"2026-09-12T04:00:43.024697Z","steps":["trace[992680343] 'agreement among raft nodes before linearized reading' (duration: 829.678269ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:00:43.024722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:00:42.194947Z","time spent":"829.770481ms","remote":"127.0.0.1:36498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"warn","ts":"2026-09-12T04:00:43.024761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:00:42.315808Z","time spent":"708.379153ms","remote":"127.0.0.1:36416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-12T04:00:43.02487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"919.666398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T04:00:43.024894Z","caller":"traceutil/trace.go:171","msg":"trace[1539395531] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:0; response_revision:259; }","duration":"919.72066ms","start":"2026-09-12T04:00:42.105167Z","end":"2026-09-12T04:00:43.024888Z","steps":["trace[1539395531] 'agreement among raft nodes before linearized reading' (duration: 919.685629ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:00:43.024912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:00:42.105151Z","time spent":"919.756471ms","remote":"127.0.0.1:36694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" "} {"level":"warn","ts":"2026-09-12T04:00:43.026216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:00:42.315506Z","time spent":"708.353601ms","remote":"127.0.0.1:36416","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-12T04:00:43.026715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.324385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-09-12T04:00:43.026749Z","caller":"traceutil/trace.go:171","msg":"trace[1173294799] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:260; }","duration":"631.360246ms","start":"2026-09-12T04:00:42.39538Z","end":"2026-09-12T04:00:43.026741Z","steps":["trace[1173294799] 'agreement among raft nodes before linearized reading' (duration: 631.263693ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:00:43.026768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:00:42.39536Z","time spent":"631.403307ms","remote":"127.0.0.1:36346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-12T04:00:43.026838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.216029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-12T04:00:43.026971Z","caller":"traceutil/trace.go:171","msg":"trace[59644967] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:260; }","duration":"351.384214ms","start":"2026-09-12T04:00:42.675534Z","end":"2026-09-12T04:00:43.026918Z","steps":["trace[59644967] 'agreement among raft nodes before linearized reading' (duration: 351.093395ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:00:43.027033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:00:42.675509Z","time spent":"351.512969ms","remote":"127.0.0.1:36498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-12T04:00:59.67781Z","caller":"traceutil/trace.go:171","msg":"trace[819993158] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"189.442788ms","start":"2026-09-12T04:00:59.488293Z","end":"2026-09-12T04:00:59.677736Z","steps":["trace[819993158] 'process raft request' (duration: 189.088657ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:01:17.173217Z","caller":"traceutil/trace.go:171","msg":"trace[2061138092] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"193.634971ms","start":"2026-09-12T04:01:16.97956Z","end":"2026-09-12T04:01:17.173195Z","steps":["trace[2061138092] 'process raft request' (duration: 181.790553ms)","trace[2061138092] 'compare' (duration: 11.640992ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:01:17.173729Z","caller":"traceutil/trace.go:171","msg":"trace[1215117772] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"192.734543ms","start":"2026-09-12T04:01:16.980969Z","end":"2026-09-12T04:01:17.173704Z","steps":["trace[1215117772] 'process raft request' (duration: 192.179515ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:01:17.17496Z","caller":"traceutil/trace.go:171","msg":"trace[386049759] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"134.699608ms","start":"2026-09-12T04:01:17.040234Z","end":"2026-09-12T04:01:17.174933Z","steps":["trace[386049759] 'process raft request' (duration: 133.614803ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:01:17.61777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.494903ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T04:01:17.617886Z","caller":"traceutil/trace.go:171","msg":"trace[1138362863] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"181.567826ms","start":"2026-09-12T04:01:17.436297Z","end":"2026-09-12T04:01:17.617864Z","steps":["trace[1138362863] 'process raft request' (duration: 75.883276ms)","trace[1138362863] 'compare' (duration: 105.3633ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:01:17.639435Z","caller":"traceutil/trace.go:171","msg":"trace[985271169] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"191.013927ms","start":"2026-09-12T04:01:17.448388Z","end":"2026-09-12T04:01:17.639402Z","steps":["trace[985271169] 'process raft request' (duration: 190.532352ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:01:17.639654Z","caller":"traceutil/trace.go:171","msg":"trace[1509688362] linearizableReadLoop","detail":"{readStateIndex:586; appliedIndex:584; }","duration":"112.92705ms","start":"2026-09-12T04:01:17.526688Z","end":"2026-09-12T04:01:17.639615Z","steps":["trace[1509688362] 'read index received' (duration: 111.99788ms)","trace[1509688362] 'applied index is now lower than readState.Index' (duration: 927.219µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:01:17.639693Z","caller":"traceutil/trace.go:171","msg":"trace[836651385] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"141.485944ms","start":"2026-09-12T04:01:17.498163Z","end":"2026-09-12T04:01:17.639649Z","steps":["trace[836651385] 'process raft request' (duration: 141.145423ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:01:17.639982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.263342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-12T04:01:17.640032Z","caller":"traceutil/trace.go:171","msg":"trace[24098931] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:560; }","duration":"113.376435ms","start":"2026-09-12T04:01:17.526643Z","end":"2026-09-12T04:01:17.640019Z","steps":["trace[24098931] 'agreement among raft nodes before linearized reading' (duration: 113.145018ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:01:18.061671Z","caller":"traceutil/trace.go:171","msg":"trace[1127636033] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"416.004953ms","start":"2026-09-12T04:01:17.645602Z","end":"2026-09-12T04:01:18.061607Z","steps":["trace[1127636033] 'process raft request' (duration: 407.044713ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:01:18.061822Z","caller":"traceutil/trace.go:171","msg":"trace[545974789] linearizableReadLoop","detail":"{readStateIndex:591; appliedIndex:587; }","duration":"197.352458ms","start":"2026-09-12T04:01:17.864458Z","end":"2026-09-12T04:01:18.061811Z","steps":["trace[545974789] 'read index received' (duration: 188.302538ms)","trace[545974789] 'applied index is now lower than readState.Index' (duration: 9.04928ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:01:18.061738Z","caller":"traceutil/trace.go:171","msg":"trace[398884604] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"383.336258ms","start":"2026-09-12T04:01:17.678345Z","end":"2026-09-12T04:01:18.061681Z","steps":["trace[398884604] 'process raft request' (duration: 383.144355ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:01:18.061888Z","caller":"traceutil/trace.go:171","msg":"trace[1195135465] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"301.004243ms","start":"2026-09-12T04:01:17.760878Z","end":"2026-09-12T04:01:18.061882Z","steps":["trace[1195135465] 'process raft request' (duration: 300.690787ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:01:18.061931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:01:17.760853Z","time spent":"301.047933ms","remote":"127.0.0.1:36264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":73770,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-12T04:01:18.061933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:01:17.645556Z","time spent":"416.250888ms","remote":"127.0.0.1:36498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T04:01:18.06196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:01:17.67832Z","time spent":"383.572652ms","remote":"127.0.0.1:36264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18032,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T04:01:18.062034Z","caller":"traceutil/trace.go:171","msg":"trace[394857153] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"296.258198ms","start":"2026-09-12T04:01:17.765769Z","end":"2026-09-12T04:01:18.062027Z","steps":["trace[394857153] 'process raft request' (duration: 295.881592ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:01:18.062115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.667063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-12T04:01:18.062138Z","caller":"traceutil/trace.go:171","msg":"trace[224652301] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:565; }","duration":"197.833918ms","start":"2026-09-12T04:01:17.864298Z","end":"2026-09-12T04:01:18.062132Z","steps":["trace[224652301] 'agreement among raft nodes before linearized reading' (duration: 197.770657ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:01:23.718986Z","caller":"traceutil/trace.go:171","msg":"trace[646640322] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"322.05649ms","start":"2026-09-12T04:01:23.396899Z","end":"2026-09-12T04:01:23.718956Z","steps":["trace[646640322] 'process raft request' (duration: 321.439689ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:01:23.71916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:01:23.396868Z","time spent":"322.199894ms","remote":"127.0.0.1:36324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T04:01:24.427321Z","caller":"traceutil/trace.go:171","msg":"trace[1398077983] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"620.690286ms","start":"2026-09-12T04:01:23.806596Z","end":"2026-09-12T04:01:24.427286Z","steps":["trace[1398077983] 'process raft request' (duration: 620.447442ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:01:24.427761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:01:23.80657Z","time spent":"620.846599ms","remote":"127.0.0.1:36576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-12T04:01:24.584756Z","caller":"traceutil/trace.go:171","msg":"trace[382521769] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:641; }","duration":"496.034169ms","start":"2026-09-12T04:01:24.088695Z","end":"2026-09-12T04:01:24.584729Z","steps":["trace[382521769] 'read index received' (duration: 338.48618ms)","trace[382521769] 'applied index is now lower than readState.Index' (duration: 157.547038ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:01:24.584893Z","caller":"traceutil/trace.go:171","msg":"trace[329315012] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"700.198458ms","start":"2026-09-12T04:01:23.884681Z","end":"2026-09-12T04:01:24.584879Z","steps":["trace[329315012] 'process raft request' (duration: 642.383722ms)","trace[329315012] 'compare' (duration: 57.46088ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T04:01:24.584996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:01:23.884631Z","time spent":"700.28911ms","remote":"127.0.0.1:36498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T04:01:24.585197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.28116ms","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-09-12T04:01:24.585356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.446429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T04:01:24.585412Z","caller":"traceutil/trace.go:171","msg":"trace[195429484] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"387.524561ms","start":"2026-09-12T04:01:24.197865Z","end":"2026-09-12T04:01:24.585389Z","steps":["trace[195429484] 'agreement among raft nodes before linearized reading' (duration: 387.46794ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:01:24.58539Z","caller":"traceutil/trace.go:171","msg":"trace[903621792] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:616; }","duration":"488.520965ms","start":"2026-09-12T04:01:24.096841Z","end":"2026-09-12T04:01:24.585362Z","steps":["trace[903621792] 'agreement among raft nodes before linearized reading' (duration: 488.201989ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:01:24.585387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.67949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-09-12T04:01:24.585466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:01:24.197842Z","time spent":"387.615762ms","remote":"127.0.0.1:36192","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-09-12T04:01:24.585479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:01:24.096793Z","time spent":"488.667838ms","remote":"127.0.0.1:36498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-12T04:01:24.585248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.935931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-12T04:01:24.585494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.594455ms","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-09-12T04:01:24.585484Z","caller":"traceutil/trace.go:171","msg":"trace[1584751633] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:616; }","duration":"496.779592ms","start":"2026-09-12T04:01:24.088687Z","end":"2026-09-12T04:01:24.585466Z","steps":["trace[1584751633] 'agreement among raft nodes before linearized reading' (duration: 496.561678ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:01:24.585551Z","caller":"traceutil/trace.go:171","msg":"trace[1526880657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:616; }","duration":"479.682787ms","start":"2026-09-12T04:01:24.105853Z","end":"2026-09-12T04:01:24.585536Z","steps":["trace[1526880657] 'agreement among raft nodes before linearized reading' (duration: 479.493464ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:01:24.585573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:01:24.088584Z","time spent":"496.976096ms","remote":"127.0.0.1:36498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-12T04:01:24.585583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:01:24.105839Z","time spent":"479.736758ms","remote":"127.0.0.1:36498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-12T04:01:24.585626Z","caller":"traceutil/trace.go:171","msg":"trace[632159871] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:616; }","duration":"143.359889ms","start":"2026-09-12T04:01:24.442207Z","end":"2026-09-12T04:01:24.585567Z","steps":["trace[632159871] 'agreement among raft nodes before linearized reading' (duration: 142.89692ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:01:25.641715Z","caller":"traceutil/trace.go:171","msg":"trace[837030468] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"119.899435ms","start":"2026-09-12T04:01:25.521786Z","end":"2026-09-12T04:01:25.641685Z","steps":["trace[837030468] 'process raft request' (duration: 116.48896ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:01:41.977148Z","caller":"traceutil/trace.go:171","msg":"trace[202420991] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"126.290337ms","start":"2026-09-12T04:01:41.850824Z","end":"2026-09-12T04:01:41.977114Z","steps":["trace[202420991] 'process raft request' (duration: 126.089632ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:01:56.050654Z","caller":"traceutil/trace.go:171","msg":"trace[895964099] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"117.06635ms","start":"2026-09-12T04:01:55.933562Z","end":"2026-09-12T04:01:56.050628Z","steps":["trace[895964099] 'process raft request' (duration: 116.62042ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:03:06.149484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.985955ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T04:03:06.149714Z","caller":"traceutil/trace.go:171","msg":"trace[134205175] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"461.406188ms","start":"2026-09-12T04:03:05.688271Z","end":"2026-09-12T04:03:06.149678Z","steps":["trace[134205175] 'process raft request' (duration: 84.115065ms)","trace[134205175] 'compare' (duration: 376.847831ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T04:03:06.149897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:03:05.688239Z","time spent":"461.560653ms","remote":"127.0.0.1:36498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T04:03:06.149937Z","caller":"traceutil/trace.go:171","msg":"trace[195951778] linearizableReadLoop","detail":"{readStateIndex:1958; appliedIndex:1957; }","duration":"230.739957ms","start":"2026-09-12T04:03:05.919162Z","end":"2026-09-12T04:03:06.149902Z","steps":["trace[195951778] 'read index received' (duration: 118.243µs)","trace[195951778] 'applied index is now lower than readState.Index' (duration: 230.618354ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T04:03:06.231812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.623132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ab228eef-2dc7-4f25-aadb-9b1ea1727302\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-12T04:03:06.231887Z","caller":"traceutil/trace.go:171","msg":"trace[873823660] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ab228eef-2dc7-4f25-aadb-9b1ea1727302; range_end:; response_count:1; response_revision:1879; }","duration":"312.745917ms","start":"2026-09-12T04:03:05.919121Z","end":"2026-09-12T04:03:06.231867Z","steps":["trace[873823660] 'agreement among raft nodes before linearized reading' (duration: 230.973614ms)","trace[873823660] 'range keys from in-memory index tree' (duration: 81.569637ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T04:03:06.231926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:03:05.9191Z","time spent":"312.817179ms","remote":"127.0.0.1:36416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ab228eef-2dc7-4f25-aadb-9b1ea1727302\" "} {"level":"warn","ts":"2026-09-12T04:03:06.231948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.462976ms","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-09-12T04:03:06.232037Z","caller":"traceutil/trace.go:171","msg":"trace[433629911] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1879; }","duration":"304.58502ms","start":"2026-09-12T04:03:05.92743Z","end":"2026-09-12T04:03:06.232015Z","steps":["trace[433629911] 'agreement among raft nodes before linearized reading' (duration: 304.215449ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:03:06.232092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:03:05.927412Z","time spent":"304.667453ms","remote":"127.0.0.1:36498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-09-12T04:03:06.528406Z","caller":"traceutil/trace.go:171","msg":"trace[206367060] linearizableReadLoop","detail":"{readStateIndex:1961; appliedIndex:1960; }","duration":"165.702774ms","start":"2026-09-12T04:03:06.362677Z","end":"2026-09-12T04:03:06.52838Z","steps":["trace[206367060] 'read index received' (duration: 110.544145ms)","trace[206367060] 'applied index is now lower than readState.Index' (duration: 55.157559ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:03:06.528596Z","caller":"traceutil/trace.go:171","msg":"trace[1376244068] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"289.320565ms","start":"2026-09-12T04:03:06.23926Z","end":"2026-09-12T04:03:06.528581Z","steps":["trace[1376244068] 'process raft request' (duration: 233.94709ms)","trace[1376244068] 'compare' (duration: 55.046896ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T04:03:06.528786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.091926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-12T04:03:06.52883Z","caller":"traceutil/trace.go:171","msg":"trace[1594932415] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1881; }","duration":"166.180228ms","start":"2026-09-12T04:03:06.362638Z","end":"2026-09-12T04:03:06.528818Z","steps":["trace[1594932415] 'agreement among raft nodes before linearized reading' (duration: 166.011604ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:03:06.695152Z","caller":"traceutil/trace.go:171","msg":"trace[542408790] linearizableReadLoop","detail":"{readStateIndex:1962; appliedIndex:1961; }","duration":"166.5803ms","start":"2026-09-12T04:03:06.528547Z","end":"2026-09-12T04:03:06.695127Z","steps":["trace[542408790] 'read index received' (duration: 141.805719ms)","trace[542408790] 'applied index is now lower than readState.Index' (duration: 24.773451ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:03:06.695206Z","caller":"traceutil/trace.go:171","msg":"trace[599139747] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"309.53588ms","start":"2026-09-12T04:03:06.385634Z","end":"2026-09-12T04:03:06.69517Z","steps":["trace[599139747] 'process raft request' (duration: 284.747239ms)","trace[599139747] 'compare' (duration: 24.521084ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T04:03:06.695447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:03:06.385607Z","time spent":"309.775008ms","remote":"127.0.0.1:36498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T04:03:06.695526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.538809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ab228eef-2dc7-4f25-aadb-9b1ea1727302\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-09-12T04:03:06.695603Z","caller":"traceutil/trace.go:171","msg":"trace[301328392] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ab228eef-2dc7-4f25-aadb-9b1ea1727302; range_end:; response_count:1; response_revision:1882; }","duration":"142.697263ms","start":"2026-09-12T04:03:06.552893Z","end":"2026-09-12T04:03:06.69559Z","steps":["trace[301328392] 'agreement among raft nodes before linearized reading' (duration: 142.379845ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:03:06.695572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.079717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-12T04:03:06.695804Z","caller":"traceutil/trace.go:171","msg":"trace[1777824889] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1882; }","duration":"199.320874ms","start":"2026-09-12T04:03:06.496406Z","end":"2026-09-12T04:03:06.695727Z","steps":["trace[1777824889] 'agreement among raft nodes before linearized reading' (duration: 198.83267ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:03:20.034978Z","caller":"traceutil/trace.go:171","msg":"trace[1894482431] transaction","detail":"{read_only:false; response_revision:1998; number_of_response:1; }","duration":"186.554495ms","start":"2026-09-12T04:03:19.848363Z","end":"2026-09-12T04:03:20.034917Z","steps":["trace[1894482431] 'process raft request' (duration: 186.340989ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:03:47.23341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.743146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-12T04:03:47.233605Z","caller":"traceutil/trace.go:171","msg":"trace[1750986384] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:2149; }","duration":"103.957403ms","start":"2026-09-12T04:03:47.129629Z","end":"2026-09-12T04:03:47.233586Z","steps":["trace[1750986384] 'count revisions from in-memory index tree' (duration: 103.666514ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:03:47.721757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.982994ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T04:03:47.721877Z","caller":"traceutil/trace.go:171","msg":"trace[382297466] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"203.326062ms","start":"2026-09-12T04:03:47.518531Z","end":"2026-09-12T04:03:47.721857Z","steps":["trace[382297466] 'process raft request' (duration: 30.147703ms)","trace[382297466] 'compare' (duration: 172.881691ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:03:47.742692Z","caller":"traceutil/trace.go:171","msg":"trace[2105022634] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"223.037653ms","start":"2026-09-12T04:03:47.519639Z","end":"2026-09-12T04:03:47.742676Z","steps":["trace[2105022634] 'process raft request' (duration: 222.944131ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:03:47.742682Z","caller":"traceutil/trace.go:171","msg":"trace[112961947] linearizableReadLoop","detail":"{readStateIndex:2243; appliedIndex:2240; }","duration":"125.325081ms","start":"2026-09-12T04:03:47.617339Z","end":"2026-09-12T04:03:47.742664Z","steps":["trace[112961947] 'read index received' (duration: 125.100985ms)","trace[112961947] 'applied index is now lower than readState.Index' (duration: 223.216µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:03:47.742825Z","caller":"traceutil/trace.go:171","msg":"trace[217491102] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"219.263543ms","start":"2026-09-12T04:03:47.523554Z","end":"2026-09-12T04:03:47.742818Z","steps":["trace[217491102] 'process raft request' (duration: 219.074848ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:03:47.742792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.414774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T04:03:47.74298Z","caller":"traceutil/trace.go:171","msg":"trace[1202574592] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2154; }","duration":"125.673172ms","start":"2026-09-12T04:03:47.617294Z","end":"2026-09-12T04:03:47.742967Z","steps":["trace[1202574592] 'agreement among raft nodes before linearized reading' (duration: 125.419294ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:03:47.743287Z","caller":"traceutil/trace.go:171","msg":"trace[1972230720] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"223.988741ms","start":"2026-09-12T04:03:47.519253Z","end":"2026-09-12T04:03:47.743242Z","steps":["trace[1972230720] 'process raft request' (duration: 223.185429ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:05:42.528122Z","caller":"traceutil/trace.go:171","msg":"trace[2059215259] transaction","detail":"{read_only:false; response_revision:2872; number_of_response:1; }","duration":"140.734214ms","start":"2026-09-12T04:05:42.387355Z","end":"2026-09-12T04:05:42.52809Z","steps":["trace[2059215259] 'process raft request' (duration: 133.194921ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:05:42.538642Z","caller":"traceutil/trace.go:171","msg":"trace[1050245304] transaction","detail":"{read_only:false; response_revision:2873; number_of_response:1; }","duration":"151.209223ms","start":"2026-09-12T04:05:42.387406Z","end":"2026-09-12T04:05:42.538615Z","steps":["trace[1050245304] 'process raft request' (duration: 151.065188ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:05:48.078074Z","caller":"traceutil/trace.go:171","msg":"trace[159594878] transaction","detail":"{read_only:false; response_revision:2900; number_of_response:1; }","duration":"103.26482ms","start":"2026-09-12T04:05:47.97478Z","end":"2026-09-12T04:05:48.078045Z","steps":["trace[159594878] 'process raft request' (duration: 103.100225ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:05:53.46859Z","caller":"traceutil/trace.go:171","msg":"trace[1714922044] transaction","detail":"{read_only:false; response_revision:2930; number_of_response:1; }","duration":"124.007021ms","start":"2026-09-12T04:05:53.344558Z","end":"2026-09-12T04:05:53.468565Z","steps":["trace[1714922044] 'process raft request' (duration: 123.840716ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:05:53.711184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.628126ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T04:05:53.711265Z","caller":"traceutil/trace.go:171","msg":"trace[509458596] linearizableReadLoop","detail":"{readStateIndex:3048; appliedIndex:3046; }","duration":"245.309216ms","start":"2026-09-12T04:05:53.465941Z","end":"2026-09-12T04:05:53.71125Z","steps":["trace[509458596] 'read index received' (duration: 2.48872ms)","trace[509458596] 'applied index is now lower than readState.Index' (duration: 242.819406ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:05:53.711323Z","caller":"traceutil/trace.go:171","msg":"trace[878497206] transaction","detail":"{read_only:false; response_revision:2931; number_of_response:1; }","duration":"263.417525ms","start":"2026-09-12T04:05:53.4479Z","end":"2026-09-12T04:05:53.711317Z","steps":["trace[878497206] 'process raft request' (duration: 160.580992ms)","trace[878497206] 'compare' (duration: 102.494661ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T04:05:53.711475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.105045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T04:05:53.711594Z","caller":"traceutil/trace.go:171","msg":"trace[534334888] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:2931; }","duration":"203.290271ms","start":"2026-09-12T04:05:53.508284Z","end":"2026-09-12T04:05:53.711574Z","steps":["trace[534334888] 'agreement among raft nodes before linearized reading' (duration: 203.094234ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:05:53.71189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.889227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-12T04:05:53.71199Z","caller":"traceutil/trace.go:171","msg":"trace[1636279029] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:2931; }","duration":"246.048792ms","start":"2026-09-12T04:05:53.46591Z","end":"2026-09-12T04:05:53.711959Z","steps":["trace[1636279029] 'agreement among raft nodes before linearized reading' (duration: 245.871106ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:05:53.712054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.413884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-12T04:05:53.712139Z","caller":"traceutil/trace.go:171","msg":"trace[1022247094] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2931; }","duration":"103.619122ms","start":"2026-09-12T04:05:53.608502Z","end":"2026-09-12T04:05:53.712121Z","steps":["trace[1022247094] 'agreement among raft nodes before linearized reading' (duration: 103.320861ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:10:36.742716Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2843} {"level":"info","ts":"2026-09-12T04:10:37.004021Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2843,"took":"260.150121ms","hash":1499724337,"current-db-size-bytes":41545728,"current-db-size":"42 MB","current-db-size-in-use-bytes":16662528,"current-db-size-in-use":"17 MB"} {"level":"info","ts":"2026-09-12T04:10:37.004077Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1499724337,"revision":2843,"compact-revision":-1} {"level":"info","ts":"2026-09-12T04:10:52.48045Z","caller":"traceutil/trace.go:171","msg":"trace[1798103934] linearizableReadLoop","detail":"{readStateIndex:5304; appliedIndex:5303; }","duration":"135.000821ms","start":"2026-09-12T04:10:52.345413Z","end":"2026-09-12T04:10:52.480414Z","steps":["trace[1798103934] 'read index received' (duration: 134.701772ms)","trace[1798103934] 'applied index is now lower than readState.Index' (duration: 297.519µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:10:52.48061Z","caller":"traceutil/trace.go:171","msg":"trace[1782849669] transaction","detail":"{read_only:false; response_revision:5100; number_of_response:1; }","duration":"169.517104ms","start":"2026-09-12T04:10:52.311004Z","end":"2026-09-12T04:10:52.480521Z","steps":["trace[1782849669] 'process raft request' (duration: 169.230845ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:10:52.480787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.354583ms","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-09-12T04:10:52.480791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.606686ms","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-09-12T04:10:52.480828Z","caller":"traceutil/trace.go:171","msg":"trace[293063758] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5100; }","duration":"135.442466ms","start":"2026-09-12T04:10:52.345373Z","end":"2026-09-12T04:10:52.480816Z","steps":["trace[293063758] 'agreement among raft nodes before linearized reading' (duration: 135.252889ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:10:52.480852Z","caller":"traceutil/trace.go:171","msg":"trace[738680891] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5100; }","duration":"124.72201ms","start":"2026-09-12T04:10:52.356111Z","end":"2026-09-12T04:10:52.480833Z","steps":["trace[738680891] 'agreement among raft nodes before linearized reading' (duration: 124.537473ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:10:52.602746Z","caller":"traceutil/trace.go:171","msg":"trace[2093474170] transaction","detail":"{read_only:false; response_revision:5101; number_of_response:1; }","duration":"113.791377ms","start":"2026-09-12T04:10:52.488918Z","end":"2026-09-12T04:10:52.602709Z","steps":["trace[2093474170] 'process raft request' (duration: 93.586183ms)","trace[2093474170] 'compare' (duration: 19.45705ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:10:52.603056Z","caller":"traceutil/trace.go:171","msg":"trace[2019983610] transaction","detail":"{read_only:false; response_revision:5102; number_of_response:1; }","duration":"113.957012ms","start":"2026-09-12T04:10:52.489023Z","end":"2026-09-12T04:10:52.60298Z","steps":["trace[2019983610] 'process raft request' (duration: 113.579201ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:10:52.603242Z","caller":"traceutil/trace.go:171","msg":"trace[433889612] transaction","detail":"{read_only:false; response_revision:5103; number_of_response:1; }","duration":"114.150988ms","start":"2026-09-12T04:10:52.48905Z","end":"2026-09-12T04:10:52.603201Z","steps":["trace[433889612] 'process raft request' (duration: 114.003013ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:10:57.623525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.671968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T04:10:57.623654Z","caller":"traceutil/trace.go:171","msg":"trace[2047960213] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:5214; }","duration":"104.865405ms","start":"2026-09-12T04:10:57.518767Z","end":"2026-09-12T04:10:57.623632Z","steps":["trace[2047960213] 'count revisions from in-memory index tree' (duration: 104.563815ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:11:03.630109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.201566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-09-12T04:11:03.630199Z","caller":"traceutil/trace.go:171","msg":"trace[351528636] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5255; }","duration":"292.348132ms","start":"2026-09-12T04:11:03.33783Z","end":"2026-09-12T04:11:03.630178Z","steps":["trace[351528636] 'range keys from in-memory index tree' (duration: 292.016951ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:11:03.630364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.642804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-12T04:11:03.630508Z","caller":"traceutil/trace.go:171","msg":"trace[489429125] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5255; }","duration":"172.841312ms","start":"2026-09-12T04:11:03.457639Z","end":"2026-09-12T04:11:03.63048Z","steps":["trace[489429125] 'range keys from in-memory index tree' (duration: 172.436268ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:11:03.630915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.278962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-09-12T04:11:03.630925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.342122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-12T04:11:03.631002Z","caller":"traceutil/trace.go:171","msg":"trace[917734612] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5255; }","duration":"195.389736ms","start":"2026-09-12T04:11:03.435593Z","end":"2026-09-12T04:11:03.630983Z","steps":["trace[917734612] 'range keys from in-memory index tree' (duration: 195.083946ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:11:03.631273Z","caller":"traceutil/trace.go:171","msg":"trace[912152042] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5255; }","duration":"208.442445ms","start":"2026-09-12T04:11:03.422547Z","end":"2026-09-12T04:11:03.63099Z","steps":["trace[912152042] 'range keys from in-memory index tree' (duration: 208.089804ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:11:03.630924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.95101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-7587799994-xkrjw.18d4776d1316baeb\" ","response":"range_response_count:1 size:896"} {"level":"info","ts":"2026-09-12T04:11:03.631407Z","caller":"traceutil/trace.go:171","msg":"trace[957980404] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-7587799994-xkrjw.18d4776d1316baeb; range_end:; response_count:1; response_revision:5255; }","duration":"293.443575ms","start":"2026-09-12T04:11:03.337904Z","end":"2026-09-12T04:11:03.631348Z","steps":["trace[957980404] 'range keys from in-memory index tree' (duration: 292.768015ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:11:10.910886Z","caller":"traceutil/trace.go:171","msg":"trace[1868197161] transaction","detail":"{read_only:false; response_revision:5416; number_of_response:1; }","duration":"196.409553ms","start":"2026-09-12T04:11:10.714443Z","end":"2026-09-12T04:11:10.910853Z","steps":["trace[1868197161] 'process raft request' (duration: 148.02498ms)","trace[1868197161] 'compare' (duration: 48.101755ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T04:11:10.911344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.420367ms","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-09-12T04:11:10.911781Z","caller":"traceutil/trace.go:171","msg":"trace[813070422] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5416; }","duration":"183.907863ms","start":"2026-09-12T04:11:10.727847Z","end":"2026-09-12T04:11:10.911755Z","steps":["trace[813070422] 'agreement among raft nodes before linearized reading' (duration: 183.342596ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:11:10.911542Z","caller":"traceutil/trace.go:171","msg":"trace[528522010] linearizableReadLoop","detail":"{readStateIndex:5630; appliedIndex:5629; }","duration":"182.89459ms","start":"2026-09-12T04:11:10.727917Z","end":"2026-09-12T04:11:10.910811Z","steps":["trace[528522010] 'read index received' (duration: 134.492387ms)","trace[528522010] 'applied index is now lower than readState.Index' (duration: 48.401213ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:11:11.279127Z","caller":"traceutil/trace.go:171","msg":"trace[1289183486] transaction","detail":"{read_only:false; response_revision:5418; number_of_response:1; }","duration":"257.322488ms","start":"2026-09-12T04:11:11.021783Z","end":"2026-09-12T04:11:11.279105Z","steps":["trace[1289183486] 'process raft request' (duration: 253.315723ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:11:54.091328Z","caller":"traceutil/trace.go:171","msg":"trace[1353817967] transaction","detail":"{read_only:false; response_revision:5817; number_of_response:1; }","duration":"111.412122ms","start":"2026-09-12T04:11:53.979886Z","end":"2026-09-12T04:11:54.091298Z","steps":["trace[1353817967] 'process raft request' (duration: 111.127413ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:12:05.685365Z","caller":"traceutil/trace.go:171","msg":"trace[1635749238] linearizableReadLoop","detail":"{readStateIndex:6105; appliedIndex:6104; }","duration":"128.627546ms","start":"2026-09-12T04:12:05.556713Z","end":"2026-09-12T04:12:05.685341Z","steps":["trace[1635749238] 'read index received' (duration: 128.524802ms)","trace[1635749238] 'applied index is now lower than readState.Index' (duration: 101.944µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:12:05.685478Z","caller":"traceutil/trace.go:171","msg":"trace[1931252792] transaction","detail":"{read_only:false; response_revision:5879; number_of_response:1; }","duration":"154.468539ms","start":"2026-09-12T04:12:05.530996Z","end":"2026-09-12T04:12:05.685464Z","steps":["trace[1931252792] 'process raft request' (duration: 154.213992ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:12:05.68571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.976976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-09-12T04:12:05.685746Z","caller":"traceutil/trace.go:171","msg":"trace[1020935022] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5879; }","duration":"129.032538ms","start":"2026-09-12T04:12:05.556704Z","end":"2026-09-12T04:12:05.685737Z","steps":["trace[1020935022] 'agreement among raft nodes before linearized reading' (duration: 128.867623ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:12:05.694471Z","caller":"traceutil/trace.go:171","msg":"trace[1326912722] transaction","detail":"{read_only:false; response_revision:5880; number_of_response:1; }","duration":"105.429713ms","start":"2026-09-12T04:12:05.589026Z","end":"2026-09-12T04:12:05.694456Z","steps":["trace[1326912722] 'process raft request' (duration: 105.106673ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:12:05.694512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.166409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-09-12T04:12:05.694546Z","caller":"traceutil/trace.go:171","msg":"trace[2063720171] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5881; }","duration":"127.20513ms","start":"2026-09-12T04:12:05.56733Z","end":"2026-09-12T04:12:05.694535Z","steps":["trace[2063720171] 'agreement among raft nodes before linearized reading' (duration: 127.122308ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:12:13.899896Z","caller":"traceutil/trace.go:171","msg":"trace[70057307] transaction","detail":"{read_only:false; response_revision:5946; number_of_response:1; }","duration":"124.98692ms","start":"2026-09-12T04:12:13.774867Z","end":"2026-09-12T04:12:13.899854Z","steps":["trace[70057307] 'process raft request' (duration: 29.892871ms)","trace[70057307] 'compare' (duration: 94.49317ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T04:12:13.899978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.519098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T04:12:13.900029Z","caller":"traceutil/trace.go:171","msg":"trace[2127494624] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5946; }","duration":"100.613471ms","start":"2026-09-12T04:12:13.799405Z","end":"2026-09-12T04:12:13.900019Z","steps":["trace[2127494624] 'agreement among raft nodes before linearized reading' (duration: 100.518989ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:12:13.899862Z","caller":"traceutil/trace.go:171","msg":"trace[1141874227] linearizableReadLoop","detail":"{readStateIndex:6174; appliedIndex:6173; }","duration":"100.366584ms","start":"2026-09-12T04:12:13.799445Z","end":"2026-09-12T04:12:13.899812Z","steps":["trace[1141874227] 'read index received' (duration: 5.254854ms)","trace[1141874227] 'applied index is now lower than readState.Index' (duration: 95.11051ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:12:13.929242Z","caller":"traceutil/trace.go:171","msg":"trace[83045218] transaction","detail":"{read_only:false; response_revision:5947; number_of_response:1; }","duration":"102.316624ms","start":"2026-09-12T04:12:13.826903Z","end":"2026-09-12T04:12:13.92922Z","steps":["trace[83045218] 'process raft request' (duration: 102.17639ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:12:13.92963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.086419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T04:12:13.929705Z","caller":"traceutil/trace.go:171","msg":"trace[2144711003] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5947; }","duration":"130.201511ms","start":"2026-09-12T04:12:13.799487Z","end":"2026-09-12T04:12:13.929689Z","steps":["trace[2144711003] 'agreement among raft nodes before linearized reading' (duration: 130.069877ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:12:13.930055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.411161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keystone-db-init-tnb7v\" ","response":"range_response_count:1 size:7336"} {"level":"info","ts":"2026-09-12T04:12:13.930149Z","caller":"traceutil/trace.go:171","msg":"trace[1132096708] range","detail":"{range_begin:/registry/pods/openstack/keystone-db-init-tnb7v; range_end:; response_count:1; response_revision:5947; }","duration":"106.548806ms","start":"2026-09-12T04:12:13.823581Z","end":"2026-09-12T04:12:13.93013Z","steps":["trace[1132096708] 'agreement among raft nodes before linearized reading' (duration: 105.822404ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:12:16.633183Z","caller":"traceutil/trace.go:171","msg":"trace[1333096907] transaction","detail":"{read_only:false; response_revision:5960; number_of_response:1; }","duration":"136.841608ms","start":"2026-09-12T04:12:16.496313Z","end":"2026-09-12T04:12:16.633154Z","steps":["trace[1333096907] 'process raft request' (duration: 136.693174ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:12:16.633195Z","caller":"traceutil/trace.go:171","msg":"trace[989876021] linearizableReadLoop","detail":"{readStateIndex:6189; appliedIndex:6188; }","duration":"128.983363ms","start":"2026-09-12T04:12:16.504181Z","end":"2026-09-12T04:12:16.633165Z","steps":["trace[989876021] 'read index received' (duration: 128.946802ms)","trace[989876021] 'applied index is now lower than readState.Index' (duration: 32.801µs)"],"step_count":2} {"level":"warn","ts":"2026-09-12T04:12:16.633609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.400956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T04:12:16.633699Z","caller":"traceutil/trace.go:171","msg":"trace[1911722012] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:5960; }","duration":"129.54099ms","start":"2026-09-12T04:12:16.504142Z","end":"2026-09-12T04:12:16.633683Z","steps":["trace[1911722012] 'agreement among raft nodes before linearized reading' (duration: 129.157368ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:12:20.528166Z","caller":"traceutil/trace.go:171","msg":"trace[1507442012] linearizableReadLoop","detail":"{readStateIndex:6211; appliedIndex:6210; }","duration":"140.500631ms","start":"2026-09-12T04:12:20.387649Z","end":"2026-09-12T04:12:20.52815Z","steps":["trace[1507442012] 'read index received' (duration: 140.329916ms)","trace[1507442012] 'applied index is now lower than readState.Index' (duration: 170.115µs)"],"step_count":2} {"level":"warn","ts":"2026-09-12T04:12:20.528325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.658456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-12T04:12:20.528347Z","caller":"traceutil/trace.go:171","msg":"trace[1577429847] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5982; }","duration":"140.735348ms","start":"2026-09-12T04:12:20.387605Z","end":"2026-09-12T04:12:20.528341Z","steps":["trace[1577429847] 'agreement among raft nodes before linearized reading' (duration: 140.620155ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:12:20.528433Z","caller":"traceutil/trace.go:171","msg":"trace[2121747716] transaction","detail":"{read_only:false; response_revision:5982; number_of_response:1; }","duration":"168.596014ms","start":"2026-09-12T04:12:20.359831Z","end":"2026-09-12T04:12:20.528427Z","steps":["trace[2121747716] 'process raft request' (duration: 168.201502ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:12:25.352542Z","caller":"traceutil/trace.go:171","msg":"trace[1854056063] transaction","detail":"{read_only:false; response_revision:6021; number_of_response:1; }","duration":"122.519499ms","start":"2026-09-12T04:12:25.229995Z","end":"2026-09-12T04:12:25.352515Z","steps":["trace[1854056063] 'process raft request' (duration: 122.426436ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:12:25.352632Z","caller":"traceutil/trace.go:171","msg":"trace[1148841803] transaction","detail":"{read_only:false; response_revision:6020; number_of_response:1; }","duration":"125.715008ms","start":"2026-09-12T04:12:25.226866Z","end":"2026-09-12T04:12:25.352581Z","steps":["trace[1148841803] 'process raft request' (duration: 123.041865ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:12:36.291129Z","caller":"traceutil/trace.go:171","msg":"trace[420434107] transaction","detail":"{read_only:false; response_revision:6098; number_of_response:1; }","duration":"138.191575ms","start":"2026-09-12T04:12:36.152905Z","end":"2026-09-12T04:12:36.291097Z","steps":["trace[420434107] 'process raft request' (duration: 103.955021ms)","trace[420434107] 'compare' (duration: 33.864003ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T04:12:36.291395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.330931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-12T04:12:36.291425Z","caller":"traceutil/trace.go:171","msg":"trace[765896258] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:6099; }","duration":"102.409943ms","start":"2026-09-12T04:12:36.189008Z","end":"2026-09-12T04:12:36.291418Z","steps":["trace[765896258] 'agreement among raft nodes before linearized reading' (duration: 102.29925ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:12:36.681555Z","caller":"traceutil/trace.go:171","msg":"trace[87451670] transaction","detail":"{read_only:false; response_revision:6106; number_of_response:1; }","duration":"106.378526ms","start":"2026-09-12T04:12:36.575149Z","end":"2026-09-12T04:12:36.681528Z","steps":["trace[87451670] 'process raft request' (duration: 96.676625ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:12:36.681758Z","caller":"traceutil/trace.go:171","msg":"trace[1193188540] transaction","detail":"{read_only:false; response_revision:6107; number_of_response:1; }","duration":"102.527427ms","start":"2026-09-12T04:12:36.579067Z","end":"2026-09-12T04:12:36.681594Z","steps":["trace[1193188540] 'process raft request' (duration: 102.143895ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:12:39.895286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.392078ms","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-09-12T04:12:39.895369Z","caller":"traceutil/trace.go:171","msg":"trace[1228315368] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6130; }","duration":"108.531123ms","start":"2026-09-12T04:12:39.786816Z","end":"2026-09-12T04:12:39.895347Z","steps":["trace[1228315368] 'range keys from in-memory index tree' (duration: 108.204342ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:12:40.378412Z","caller":"traceutil/trace.go:171","msg":"trace[594916106] transaction","detail":"{read_only:false; response_revision:6136; number_of_response:1; }","duration":"157.336589ms","start":"2026-09-12T04:12:40.221046Z","end":"2026-09-12T04:12:40.378383Z","steps":["trace[594916106] 'process raft request' (duration: 157.104011ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:15:03.586866Z","caller":"traceutil/trace.go:171","msg":"trace[379169325] transaction","detail":"{read_only:false; response_revision:7120; number_of_response:1; }","duration":"111.296359ms","start":"2026-09-12T04:15:03.475532Z","end":"2026-09-12T04:15:03.586829Z","steps":["trace[379169325] 'process raft request' (duration: 35.951108ms)","trace[379169325] 'compare' (duration: 75.033973ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:15:36.749271Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4570} {"level":"info","ts":"2026-09-12T04:15:36.798989Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4570,"took":"48.504639ms","hash":2194937548,"current-db-size-bytes":41545728,"current-db-size":"42 MB","current-db-size-in-use-bytes":32800768,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-09-12T04:15:36.799123Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2194937548,"revision":4570,"compact-revision":2843}