{"level":"warn","ts":"2026-10-26T19:21:39.432328Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-26T19:21:39.432455Z","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-10-26T19:21:39.432542Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-26T19:21:39.432551Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.140:2380"]} {"level":"info","ts":"2026-10-26T19:21:39.432574Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-26T19:21:39.433382Z","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-10-26T19:21:39.433491Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.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-10-26T19:21:39.439048Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.681939ms"} {"level":"info","ts":"2026-10-26T19:21:39.445224Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf809824ab95ac81","cluster-id":"6f89f5fbef18dc61"} {"level":"info","ts":"2026-10-26T19:21:39.445329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=()"} {"level":"info","ts":"2026-10-26T19:21:39.445359Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 0"} {"level":"info","ts":"2026-10-26T19:21:39.445383Z","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-10-26T19:21:39.445401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 1"} {"level":"info","ts":"2026-10-26T19:21:39.445476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"} {"level":"warn","ts":"2026-10-26T19:21:39.482819Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-26T19:21:39.485454Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-26T19:21:39.488633Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-10-26T19:21:39.4939Z","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-10-26T19:21:39.494387Z","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-10-26T19:21:39.494413Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-26T19:21:39.494665Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-26T19:21:39.494712Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-26T19:21:39.496124Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"} {"level":"info","ts":"2026-10-26T19:21:39.496357Z","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-10-26T19:21:39.501324Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-26T19:21:39.501504Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.140:2380"} {"level":"info","ts":"2026-10-26T19:21:39.501627Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.140:2380"} {"level":"info","ts":"2026-10-26T19:21:39.501731Z","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-10-26T19:21:39.50182Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-26T19:21:39.545916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 is starting a new election at term 1"} {"level":"info","ts":"2026-10-26T19:21:39.546028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-26T19:21:39.546089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgPreVoteResp from cf809824ab95ac81 at term 1"} {"level":"info","ts":"2026-10-26T19:21:39.546127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became candidate at term 2"} {"level":"info","ts":"2026-10-26T19:21:39.546146Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgVoteResp from cf809824ab95ac81 at term 2"} {"level":"info","ts":"2026-10-26T19:21:39.54617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became leader at term 2"} {"level":"info","ts":"2026-10-26T19:21:39.546191Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf809824ab95ac81 elected leader cf809824ab95ac81 at term 2"} {"level":"info","ts":"2026-10-26T19:21:39.55093Z","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-10-26T19:21:39.550965Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-26T19:21:39.551245Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-26T19:21:39.551208Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T19:21:39.555141Z","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-10-26T19:21:39.555152Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-26T19:21:39.555324Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T19:21:39.555367Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T19:21:39.555302Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-26T19:21:39.555574Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.140:2379"} {"level":"info","ts":"2026-10-26T19:21:39.558971Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-26T19:21:58.432122Z","caller":"traceutil/trace.go:171","msg":"trace[641846460] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"180.697378ms","start":"2026-10-26T19:21:58.251401Z","end":"2026-10-26T19:21:58.432098Z","steps":["trace[641846460] 'process raft request' (duration: 180.551295ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:22:09.153305Z","caller":"traceutil/trace.go:171","msg":"trace[1786681333] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"101.358006ms","start":"2026-10-26T19:22:09.051915Z","end":"2026-10-26T19:22:09.153273Z","steps":["trace[1786681333] 'process raft request' (duration: 101.177753ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:22:28.02486Z","caller":"traceutil/trace.go:171","msg":"trace[1772568147] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"130.062679ms","start":"2026-10-26T19:22:27.894764Z","end":"2026-10-26T19:22:28.024827Z","steps":["trace[1772568147] 'process raft request' (duration: 129.806555ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:22:28.042182Z","caller":"traceutil/trace.go:171","msg":"trace[61482297] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"135.897141ms","start":"2026-10-26T19:22:27.906252Z","end":"2026-10-26T19:22:28.042149Z","steps":["trace[61482297] 'process raft request' (duration: 135.521773ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:22:28.292996Z","caller":"traceutil/trace.go:171","msg":"trace[661335482] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"139.299287ms","start":"2026-10-26T19:22:28.153668Z","end":"2026-10-26T19:22:28.292967Z","steps":["trace[661335482] 'process raft request' (duration: 133.111678ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:22:28.293259Z","caller":"traceutil/trace.go:171","msg":"trace[865445810] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"125.895209ms","start":"2026-10-26T19:22:28.167338Z","end":"2026-10-26T19:22:28.293233Z","steps":["trace[865445810] 'process raft request' (duration: 125.662825ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:22:35.101278Z","caller":"traceutil/trace.go:171","msg":"trace[2079764029] linearizableReadLoop","detail":"{readStateIndex:732; appliedIndex:731; }","duration":"367.164225ms","start":"2026-10-26T19:22:34.734079Z","end":"2026-10-26T19:22:35.101243Z","steps":["trace[2079764029] 'read index received' (duration: 365.637265ms)","trace[2079764029] 'applied index is now lower than readState.Index' (duration: 1.52546ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:22:35.101358Z","caller":"traceutil/trace.go:171","msg":"trace[328307459] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"414.578265ms","start":"2026-10-26T19:22:34.686749Z","end":"2026-10-26T19:22:35.101327Z","steps":["trace[328307459] 'process raft request' (duration: 413.364992ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:22:35.101607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.485171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cz2zm\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-26T19:22:35.101738Z","caller":"traceutil/trace.go:171","msg":"trace[491223485] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cz2zm; range_end:; response_count:1; response_revision:707; }","duration":"367.687325ms","start":"2026-10-26T19:22:34.734026Z","end":"2026-10-26T19:22:35.101714Z","steps":["trace[491223485] 'agreement among raft nodes before linearized reading' (duration: 367.387079ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:22:35.101786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:22:34.734004Z","time spent":"367.772846ms","remote":"127.0.0.1:35504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-cz2zm\" "} {"level":"warn","ts":"2026-10-26T19:22:35.102362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:22:34.686689Z","time spent":"414.861231ms","remote":"127.0.0.1:35390","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T19:22:35.523087Z","caller":"traceutil/trace.go:171","msg":"trace[881341371] linearizableReadLoop","detail":"{readStateIndex:733; appliedIndex:732; }","duration":"342.614213ms","start":"2026-10-26T19:22:35.180448Z","end":"2026-10-26T19:22:35.523062Z","steps":["trace[881341371] 'read index received' (duration: 342.404919ms)","trace[881341371] 'applied index is now lower than readState.Index' (duration: 208.164µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:22:35.523234Z","caller":"traceutil/trace.go:171","msg":"trace[1802867280] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"402.151897ms","start":"2026-10-26T19:22:35.121055Z","end":"2026-10-26T19:22:35.523207Z","steps":["trace[1802867280] 'process raft request' (duration: 401.81736ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:22:35.523445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:22:35.121005Z","time spent":"402.288719ms","remote":"127.0.0.1:35504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T19:22:35.52367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.161573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-26T19:22:35.523861Z","caller":"traceutil/trace.go:171","msg":"trace[1641794206] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:708; }","duration":"343.413458ms","start":"2026-10-26T19:22:35.180387Z","end":"2026-10-26T19:22:35.523801Z","steps":["trace[1641794206] 'agreement among raft nodes before linearized reading' (duration: 342.847177ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:22:35.523949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:22:35.180364Z","time spent":"343.573722ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-10-26T19:22:35.861611Z","caller":"traceutil/trace.go:171","msg":"trace[1905454429] linearizableReadLoop","detail":"{readStateIndex:734; appliedIndex:733; }","duration":"338.300869ms","start":"2026-10-26T19:22:35.52327Z","end":"2026-10-26T19:22:35.86157Z","steps":["trace[1905454429] 'read index received' (duration: 308.671501ms)","trace[1905454429] 'applied index is now lower than readState.Index' (duration: 29.627278ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:22:35.8616Z","caller":"traceutil/trace.go:171","msg":"trace[1726527494] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"331.687173ms","start":"2026-10-26T19:22:35.529852Z","end":"2026-10-26T19:22:35.861539Z","steps":["trace[1726527494] 'process raft request' (duration: 331.53664ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:22:35.861741Z","caller":"traceutil/trace.go:171","msg":"trace[290214240] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"679.221769ms","start":"2026-10-26T19:22:35.182507Z","end":"2026-10-26T19:22:35.861729Z","steps":["trace[290214240] 'process raft request' (duration: 649.424117ms)","trace[290214240] 'compare' (duration: 29.109609ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:22:35.861853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:22:35.18249Z","time spent":"679.27998ms","remote":"127.0.0.1:35540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-26T19:22:35.861948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:22:35.529828Z","time spent":"331.912257ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T19:22:35.862025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.454939ms","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-10-26T19:22:35.862073Z","caller":"traceutil/trace.go:171","msg":"trace[369879764] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:710; }","duration":"140.567821ms","start":"2026-10-26T19:22:35.721493Z","end":"2026-10-26T19:22:35.862061Z","steps":["trace[369879764] 'agreement among raft nodes before linearized reading' (duration: 140.336046ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:22:35.86217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.727158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-26T19:22:35.862233Z","caller":"traceutil/trace.go:171","msg":"trace[1761283015] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:710; }","duration":"453.817989ms","start":"2026-10-26T19:22:35.408399Z","end":"2026-10-26T19:22:35.862217Z","steps":["trace[1761283015] 'agreement among raft nodes before linearized reading' (duration: 453.644645ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:22:35.862203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.881827ms","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-10-26T19:22:35.862264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:22:35.408388Z","time spent":"453.86846ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-10-26T19:22:35.862326Z","caller":"traceutil/trace.go:171","msg":"trace[1623194666] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:710; }","duration":"535.117951ms","start":"2026-10-26T19:22:35.327176Z","end":"2026-10-26T19:22:35.862294Z","steps":["trace[1623194666] 'agreement among raft nodes before linearized reading' (duration: 534.651182ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:22:35.862387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:22:35.327135Z","time spent":"535.240913ms","remote":"127.0.0.1:35550","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":"warn","ts":"2026-10-26T19:22:36.54135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.836938ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T19:22:36.541556Z","caller":"traceutil/trace.go:171","msg":"trace[424957982] linearizableReadLoop","detail":"{readStateIndex:738; appliedIndex:735; }","duration":"670.033522ms","start":"2026-10-26T19:22:35.871503Z","end":"2026-10-26T19:22:36.541536Z","steps":["trace[424957982] 'read index received' (duration: 3.861713ms)","trace[424957982] 'applied index is now lower than readState.Index' (duration: 666.170639ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:22:36.54159Z","caller":"traceutil/trace.go:171","msg":"trace[162312721] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"672.46564ms","start":"2026-10-26T19:22:35.869079Z","end":"2026-10-26T19:22:36.541544Z","steps":["trace[162312721] 'process raft request' (duration: 166.169433ms)","trace[162312721] 'compare' (duration: 505.700776ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:22:36.54171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.209585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-10-26T19:22:36.541762Z","caller":"traceutil/trace.go:171","msg":"trace[930931183] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:713; }","duration":"670.314007ms","start":"2026-10-26T19:22:35.871434Z","end":"2026-10-26T19:22:36.541748Z","steps":["trace[930931183] 'agreement among raft nodes before linearized reading' (duration: 670.205955ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:22:36.541813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:22:35.869061Z","time spent":"672.630253ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T19:22:36.541821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:22:35.871421Z","time spent":"670.38715ms","remote":"127.0.0.1:35520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-10-26T19:22:36.541894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.00473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T19:22:36.541926Z","caller":"traceutil/trace.go:171","msg":"trace[1939811783] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"672.44144ms","start":"2026-10-26T19:22:35.869134Z","end":"2026-10-26T19:22:36.541576Z","steps":["trace[1939811783] 'process raft request' (duration: 672.313878ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:22:36.541991Z","caller":"traceutil/trace.go:171","msg":"trace[298706241] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:713; }","duration":"419.161213ms","start":"2026-10-26T19:22:36.122813Z","end":"2026-10-26T19:22:36.541974Z","steps":["trace[298706241] 'agreement among raft nodes before linearized reading' (duration: 418.99265ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:22:36.542492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:22:35.869116Z","time spent":"673.253686ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T19:22:36.542532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:22:36.122781Z","time spent":"419.736915ms","remote":"127.0.0.1:35276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-26T19:22:49.055675Z","caller":"traceutil/trace.go:171","msg":"trace[900218501] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"135.532324ms","start":"2026-10-26T19:22:48.920117Z","end":"2026-10-26T19:22:49.055649Z","steps":["trace[900218501] 'process raft request' (duration: 135.469903ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:22:49.056102Z","caller":"traceutil/trace.go:171","msg":"trace[1095452242] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"141.781424ms","start":"2026-10-26T19:22:48.914287Z","end":"2026-10-26T19:22:49.056068Z","steps":["trace[1095452242] 'process raft request' (duration: 141.08662ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:22:50.119165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.447432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T19:22:50.119263Z","caller":"traceutil/trace.go:171","msg":"trace[824965946] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:817; }","duration":"122.566774ms","start":"2026-10-26T19:22:49.996676Z","end":"2026-10-26T19:22:50.119242Z","steps":["trace[824965946] 'count revisions from in-memory index tree' (duration: 122.280719ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:22:50.118953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.233458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T19:22:50.119642Z","caller":"traceutil/trace.go:171","msg":"trace[1254123525] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:817; }","duration":"122.988403ms","start":"2026-10-26T19:22:49.996629Z","end":"2026-10-26T19:22:50.119618Z","steps":["trace[1254123525] 'range keys from in-memory index tree' (duration: 122.088316ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:22:53.305893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.745621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T19:22:53.306017Z","caller":"traceutil/trace.go:171","msg":"trace[1444976659] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:834; }","duration":"182.943205ms","start":"2026-10-26T19:22:53.123047Z","end":"2026-10-26T19:22:53.30599Z","steps":["trace[1444976659] 'range keys from in-memory index tree' (duration: 182.624939ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:23:22.456522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.708361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-26T19:23:22.456703Z","caller":"traceutil/trace.go:171","msg":"trace[934214193] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1232; }","duration":"174.950236ms","start":"2026-10-26T19:23:22.281716Z","end":"2026-10-26T19:23:22.456666Z","steps":["trace[934214193] 'count revisions from in-memory index tree' (duration: 174.541948ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:24:15.09731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.537067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-10-26T19:24:15.097439Z","caller":"traceutil/trace.go:171","msg":"trace[497835157] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1931; }","duration":"252.726611ms","start":"2026-10-26T19:24:14.84468Z","end":"2026-10-26T19:24:15.097406Z","steps":["trace[497835157] 'range keys from in-memory index tree' (duration: 252.270762ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:24:15.109501Z","caller":"traceutil/trace.go:171","msg":"trace[2118494384] transaction","detail":"{read_only:false; response_revision:1932; number_of_response:1; }","duration":"231.003074ms","start":"2026-10-26T19:24:14.87847Z","end":"2026-10-26T19:24:15.109473Z","steps":["trace[2118494384] 'process raft request' (duration: 230.837531ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:24:15.537913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.546411ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T19:24:15.538156Z","caller":"traceutil/trace.go:171","msg":"trace[159130261] linearizableReadLoop","detail":"{readStateIndex:2011; appliedIndex:2009; }","duration":"323.231274ms","start":"2026-10-26T19:24:15.2149Z","end":"2026-10-26T19:24:15.538131Z","steps":["trace[159130261] 'read index received' (duration: 12.824716ms)","trace[159130261] 'applied index is now lower than readState.Index' (duration: 310.404838ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:24:15.538298Z","caller":"traceutil/trace.go:171","msg":"trace[1484933473] transaction","detail":"{read_only:false; response_revision:1935; number_of_response:1; }","duration":"385.517618ms","start":"2026-10-26T19:24:15.152763Z","end":"2026-10-26T19:24:15.538281Z","steps":["trace[1484933473] 'process raft request' (duration: 385.291414ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:24:15.538389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:24:15.152743Z","time spent":"385.59404ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T19:24:15.538357Z","caller":"traceutil/trace.go:171","msg":"trace[46515400] transaction","detail":"{read_only:false; response_revision:1934; number_of_response:1; }","duration":"388.384713ms","start":"2026-10-26T19:24:15.149907Z","end":"2026-10-26T19:24:15.538292Z","steps":["trace[46515400] 'process raft request' (duration: 53.16628ms)","trace[46515400] 'compare' (duration: 334.392708ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:24:15.538491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.979228ms","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-10-26T19:24:15.538543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.574679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2e72c610-e234-448c-8f3f-74ebc632adcc\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-26T19:24:15.538605Z","caller":"traceutil/trace.go:171","msg":"trace[1960735020] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1935; }","duration":"212.159272ms","start":"2026-10-26T19:24:15.326425Z","end":"2026-10-26T19:24:15.538584Z","steps":["trace[1960735020] 'agreement among raft nodes before linearized reading' (duration: 211.856096ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:24:15.538613Z","caller":"traceutil/trace.go:171","msg":"trace[2025102830] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2e72c610-e234-448c-8f3f-74ebc632adcc; range_end:; response_count:1; response_revision:1935; }","duration":"323.767263ms","start":"2026-10-26T19:24:15.214826Z","end":"2026-10-26T19:24:15.538593Z","steps":["trace[2025102830] 'agreement among raft nodes before linearized reading' (duration: 323.429446ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:24:15.538502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.394269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2e72c610-e234-448c-8f3f-74ebc632adcc\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-10-26T19:24:15.538626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:24:15.149885Z","time spent":"388.611818ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T19:24:15.538659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:24:15.214806Z","time spent":"323.840125ms","remote":"127.0.0.1:35504","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-2e72c610-e234-448c-8f3f-74ebc632adcc\" "} {"level":"info","ts":"2026-10-26T19:24:15.538698Z","caller":"traceutil/trace.go:171","msg":"trace[1154712974] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2e72c610-e234-448c-8f3f-74ebc632adcc; range_end:; response_count:1; response_revision:1935; }","duration":"195.633454ms","start":"2026-10-26T19:24:15.343018Z","end":"2026-10-26T19:24:15.538651Z","steps":["trace[1154712974] 'agreement among raft nodes before linearized reading' (duration: 195.286307ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:24:29.200361Z","caller":"traceutil/trace.go:171","msg":"trace[1353558795] transaction","detail":"{read_only:false; response_revision:2051; number_of_response:1; }","duration":"301.588548ms","start":"2026-10-26T19:24:28.898704Z","end":"2026-10-26T19:24:29.200292Z","steps":["trace[1353558795] 'process raft request' (duration: 301.283872ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:24:29.200822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:24:28.898683Z","time spent":"301.979085ms","remote":"127.0.0.1:35550","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-10-26T19:25:00.155073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.175463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-26T19:25:00.155207Z","caller":"traceutil/trace.go:171","msg":"trace[862603313] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:2228; }","duration":"110.331917ms","start":"2026-10-26T19:25:00.044846Z","end":"2026-10-26T19:25:00.155178Z","steps":["trace[862603313] 'count revisions from in-memory index tree' (duration: 110.076522ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:25:12.20789Z","caller":"traceutil/trace.go:171","msg":"trace[203344096] transaction","detail":"{read_only:false; response_revision:2287; number_of_response:1; }","duration":"220.607283ms","start":"2026-10-26T19:25:11.987234Z","end":"2026-10-26T19:25:12.207841Z","steps":["trace[203344096] 'process raft request' (duration: 173.246384ms)","trace[203344096] 'compare' (duration: 46.990942ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:25:12.207944Z","caller":"traceutil/trace.go:171","msg":"trace[774420207] linearizableReadLoop","detail":"{readStateIndex:2376; appliedIndex:2374; }","duration":"110.244656ms","start":"2026-10-26T19:25:12.097656Z","end":"2026-10-26T19:25:12.207901Z","steps":["trace[774420207] 'read index received' (duration: 62.818666ms)","trace[774420207] 'applied index is now lower than readState.Index' (duration: 47.42412ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:25:12.207966Z","caller":"traceutil/trace.go:171","msg":"trace[651268283] transaction","detail":"{read_only:false; response_revision:2288; number_of_response:1; }","duration":"132.935392ms","start":"2026-10-26T19:25:12.074995Z","end":"2026-10-26T19:25:12.207931Z","steps":["trace[651268283] 'process raft request' (duration: 132.736758ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:25:12.208335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.978393ms","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-10-26T19:25:12.20846Z","caller":"traceutil/trace.go:171","msg":"trace[1170187775] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2288; }","duration":"107.143367ms","start":"2026-10-26T19:25:12.101298Z","end":"2026-10-26T19:25:12.208441Z","steps":["trace[1170187775] 'agreement among raft nodes before linearized reading' (duration: 106.840501ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:25:12.20866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.96731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5700"} {"level":"info","ts":"2026-10-26T19:25:12.208719Z","caller":"traceutil/trace.go:171","msg":"trace[1665514875] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2288; }","duration":"111.088523ms","start":"2026-10-26T19:25:12.097612Z","end":"2026-10-26T19:25:12.208701Z","steps":["trace[1665514875] 'agreement among raft nodes before linearized reading' (duration: 110.550842ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:26:00.494354Z","caller":"traceutil/trace.go:171","msg":"trace[540981048] transaction","detail":"{read_only:false; response_revision:2721; number_of_response:1; }","duration":"105.960327ms","start":"2026-10-26T19:26:00.388365Z","end":"2026-10-26T19:26:00.494325Z","steps":["trace[540981048] 'process raft request' (duration: 105.799934ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:26:00.501964Z","caller":"traceutil/trace.go:171","msg":"trace[913055766] transaction","detail":"{read_only:false; response_revision:2722; number_of_response:1; }","duration":"106.029258ms","start":"2026-10-26T19:26:00.395915Z","end":"2026-10-26T19:26:00.501944Z","steps":["trace[913055766] 'process raft request' (duration: 105.799574ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:26:34.591809Z","caller":"traceutil/trace.go:171","msg":"trace[562642852] transaction","detail":"{read_only:false; response_revision:2927; number_of_response:1; }","duration":"164.410531ms","start":"2026-10-26T19:26:34.427364Z","end":"2026-10-26T19:26:34.591775Z","steps":["trace[562642852] 'process raft request' (duration: 164.217627ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:26:34.791775Z","caller":"traceutil/trace.go:171","msg":"trace[254632136] transaction","detail":"{read_only:false; response_revision:2928; number_of_response:1; }","duration":"165.471731ms","start":"2026-10-26T19:26:34.626248Z","end":"2026-10-26T19:26:34.79172Z","steps":["trace[254632136] 'process raft request' (duration: 155.313985ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:26:34.799192Z","caller":"traceutil/trace.go:171","msg":"trace[440963633] transaction","detail":"{read_only:false; response_revision:2929; number_of_response:1; }","duration":"170.196503ms","start":"2026-10-26T19:26:34.628975Z","end":"2026-10-26T19:26:34.799171Z","steps":["trace[440963633] 'process raft request' (duration: 169.964268ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:26:34.799163Z","caller":"traceutil/trace.go:171","msg":"trace[1452498258] linearizableReadLoop","detail":"{readStateIndex:3043; appliedIndex:3041; }","duration":"100.41941ms","start":"2026-10-26T19:26:34.6987Z","end":"2026-10-26T19:26:34.799119Z","steps":["trace[1452498258] 'read index received' (duration: 83.101387ms)","trace[1452498258] 'applied index is now lower than readState.Index' (duration: 17.316463ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:26:34.799379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.661536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-26T19:26:34.799434Z","caller":"traceutil/trace.go:171","msg":"trace[992883564] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2929; }","duration":"100.792778ms","start":"2026-10-26T19:26:34.69863Z","end":"2026-10-26T19:26:34.799423Z","steps":["trace[992883564] 'agreement among raft nodes before linearized reading' (duration: 100.599885ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:26:35.205519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.1111ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T19:26:35.206056Z","caller":"traceutil/trace.go:171","msg":"trace[274342916] transaction","detail":"{read_only:false; response_revision:2930; number_of_response:1; }","duration":"402.309265ms","start":"2026-10-26T19:26:34.803704Z","end":"2026-10-26T19:26:35.206013Z","steps":["trace[274342916] 'process raft request' (duration: 153.582613ms)","trace[274342916] 'compare' (duration: 247.945287ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:26:35.206284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:26:34.80368Z","time spent":"402.504348ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T19:26:35.206791Z","caller":"traceutil/trace.go:171","msg":"trace[1798628943] transaction","detail":"{read_only:false; response_revision:2931; number_of_response:1; }","duration":"401.46705ms","start":"2026-10-26T19:26:34.804624Z","end":"2026-10-26T19:26:35.206091Z","steps":["trace[1798628943] 'process raft request' (duration: 401.051202ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:26:35.207166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:26:34.804587Z","time spent":"402.301026ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T19:31:31.054007Z","caller":"traceutil/trace.go:171","msg":"trace[1185769143] transaction","detail":"{read_only:false; response_revision:5304; number_of_response:1; }","duration":"114.750451ms","start":"2026-10-26T19:31:30.93923Z","end":"2026-10-26T19:31:31.053981Z","steps":["trace[1185769143] 'process raft request' (duration: 101.586488ms)","trace[1185769143] 'compare' (duration: 12.785407ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:31:33.717302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.826449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.140\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-10-26T19:31:33.717319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.522306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9222f3ee-3524-43a0-84af-28c62b6c39db\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-10-26T19:31:33.717409Z","caller":"traceutil/trace.go:171","msg":"trace[1813750214] range","detail":"{range_begin:/registry/masterleases/162.253.55.140; range_end:; response_count:1; response_revision:5418; }","duration":"187.979871ms","start":"2026-10-26T19:31:33.529405Z","end":"2026-10-26T19:31:33.717385Z","steps":["trace[1813750214] 'range keys from in-memory index tree' (duration: 187.618515ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:31:33.717446Z","caller":"traceutil/trace.go:171","msg":"trace[1447014904] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9222f3ee-3524-43a0-84af-28c62b6c39db; range_end:; response_count:1; response_revision:5418; }","duration":"143.75294ms","start":"2026-10-26T19:31:33.573663Z","end":"2026-10-26T19:31:33.717416Z","steps":["trace[1447014904] 'range keys from in-memory index tree' (duration: 143.177469ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:31:34.008753Z","caller":"traceutil/trace.go:171","msg":"trace[1431039071] transaction","detail":"{read_only:false; response_revision:5419; number_of_response:1; }","duration":"107.260436ms","start":"2026-10-26T19:31:33.901456Z","end":"2026-10-26T19:31:34.008716Z","steps":["trace[1431039071] 'process raft request' (duration: 100.698439ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:31:34.023392Z","caller":"traceutil/trace.go:171","msg":"trace[1391379066] linearizableReadLoop","detail":"{readStateIndex:5629; appliedIndex:5627; }","duration":"113.6338ms","start":"2026-10-26T19:31:33.909727Z","end":"2026-10-26T19:31:34.023361Z","steps":["trace[1391379066] 'read index received' (duration: 92.759987ms)","trace[1391379066] 'applied index is now lower than readState.Index' (duration: 20.872753ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:31:34.023531Z","caller":"traceutil/trace.go:171","msg":"trace[1453340513] transaction","detail":"{read_only:false; response_revision:5420; number_of_response:1; }","duration":"114.463685ms","start":"2026-10-26T19:31:33.909Z","end":"2026-10-26T19:31:34.023463Z","steps":["trace[1453340513] 'process raft request' (duration: 114.20927ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:31:34.023757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.990086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-2ldsx-tls\" ","response":"range_response_count:1 size:4424"} {"level":"info","ts":"2026-10-26T19:31:34.023825Z","caller":"traceutil/trace.go:171","msg":"trace[200247241] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-2ldsx-tls; range_end:; response_count:1; response_revision:5420; }","duration":"114.129699ms","start":"2026-10-26T19:31:33.909675Z","end":"2026-10-26T19:31:34.023805Z","steps":["trace[200247241] 'agreement among raft nodes before linearized reading' (duration: 113.811113ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:31:36.286333Z","caller":"traceutil/trace.go:171","msg":"trace[954690099] linearizableReadLoop","detail":"{readStateIndex:5672; appliedIndex:5670; }","duration":"164.172802ms","start":"2026-10-26T19:31:36.122129Z","end":"2026-10-26T19:31:36.286302Z","steps":["trace[954690099] 'read index received' (duration: 25.767777ms)","trace[954690099] 'applied index is now lower than readState.Index' (duration: 138.403315ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:31:36.286474Z","caller":"traceutil/trace.go:171","msg":"trace[1064120415] transaction","detail":"{read_only:false; response_revision:5462; number_of_response:1; }","duration":"190.914557ms","start":"2026-10-26T19:31:36.095505Z","end":"2026-10-26T19:31:36.28642Z","steps":["trace[1064120415] 'process raft request' (duration: 154.332482ms)","trace[1064120415] 'compare' (duration: 36.307749ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:31:36.286537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.390857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T19:31:36.286583Z","caller":"traceutil/trace.go:171","msg":"trace[1177980796] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5462; }","duration":"164.50625ms","start":"2026-10-26T19:31:36.12206Z","end":"2026-10-26T19:31:36.286566Z","steps":["trace[1177980796] 'agreement among raft nodes before linearized reading' (duration: 164.407078ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:31:36.28735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.553662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:787156"} {"level":"info","ts":"2026-10-26T19:31:36.287467Z","caller":"traceutil/trace.go:171","msg":"trace[1163115095] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5462; }","duration":"121.731666ms","start":"2026-10-26T19:31:36.165709Z","end":"2026-10-26T19:31:36.287441Z","steps":["trace[1163115095] 'agreement among raft nodes before linearized reading' (duration: 120.956671ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:31:40.150423Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2958} {"level":"info","ts":"2026-10-26T19:31:40.24398Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2958,"took":"91.332091ms","hash":87235665,"current-db-size-bytes":54550528,"current-db-size":"55 MB","current-db-size-in-use-bytes":30203904,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-26T19:31:40.244067Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":87235665,"revision":2958,"compact-revision":-1} {"level":"info","ts":"2026-10-26T19:31:58.59284Z","caller":"traceutil/trace.go:171","msg":"trace[1956352015] linearizableReadLoop","detail":"{readStateIndex:6086; appliedIndex:6085; }","duration":"124.203322ms","start":"2026-10-26T19:31:58.468605Z","end":"2026-10-26T19:31:58.592809Z","steps":["trace[1956352015] 'read index received' (duration: 123.951878ms)","trace[1956352015] 'applied index is now lower than readState.Index' (duration: 250.024µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:31:58.59289Z","caller":"traceutil/trace.go:171","msg":"trace[358738954] transaction","detail":"{read_only:false; response_revision:5864; number_of_response:1; }","duration":"207.487996ms","start":"2026-10-26T19:31:58.385362Z","end":"2026-10-26T19:31:58.59285Z","steps":["trace[358738954] 'process raft request' (duration: 207.225652ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:31:58.593264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.61621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0a7fa9b9-3b5e-46e9-a4c2-235676412da0\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-10-26T19:31:58.593371Z","caller":"traceutil/trace.go:171","msg":"trace[927866191] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0a7fa9b9-3b5e-46e9-a4c2-235676412da0; range_end:; response_count:1; response_revision:5864; }","duration":"124.759282ms","start":"2026-10-26T19:31:58.468585Z","end":"2026-10-26T19:31:58.593345Z","steps":["trace[927866191] 'agreement among raft nodes before linearized reading' (duration: 124.397905ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:31:58.763836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.330612ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T19:31:58.763976Z","caller":"traceutil/trace.go:171","msg":"trace[701491914] linearizableReadLoop","detail":"{readStateIndex:6087; appliedIndex:6086; }","duration":"171.007133ms","start":"2026-10-26T19:31:58.592948Z","end":"2026-10-26T19:31:58.763955Z","steps":["trace[701491914] 'read index received' (duration: 42.429547ms)","trace[701491914] 'applied index is now lower than readState.Index' (duration: 128.575726ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:31:58.764028Z","caller":"traceutil/trace.go:171","msg":"trace[983044135] transaction","detail":"{read_only:false; response_revision:5865; number_of_response:1; }","duration":"178.140021ms","start":"2026-10-26T19:31:58.585827Z","end":"2026-10-26T19:31:58.763967Z","steps":["trace[983044135] 'process raft request' (duration: 49.531524ms)","trace[983044135] 'compare' (duration: 127.71196ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:31:58.764182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.518164ms","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-10-26T19:31:58.764222Z","caller":"traceutil/trace.go:171","msg":"trace[637801540] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5865; }","duration":"265.581585ms","start":"2026-10-26T19:31:58.498629Z","end":"2026-10-26T19:31:58.76421Z","steps":["trace[637801540] 'agreement among raft nodes before linearized reading' (duration: 265.385891ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:31:58.961438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.803432ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-26T19:31:58.961827Z","caller":"traceutil/trace.go:171","msg":"trace[1811450466] transaction","detail":"{read_only:false; response_revision:5866; number_of_response:1; }","duration":"193.11606ms","start":"2026-10-26T19:31:58.768688Z","end":"2026-10-26T19:31:58.961804Z","steps":["trace[1811450466] 'process raft request' (duration: 192.900546ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:31:59.306907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.265127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0a7fa9b9-3b5e-46e9-a4c2-235676412da0\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-10-26T19:31:59.307031Z","caller":"traceutil/trace.go:171","msg":"trace[628960275] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0a7fa9b9-3b5e-46e9-a4c2-235676412da0; range_end:; response_count:1; response_revision:5866; }","duration":"118.460341ms","start":"2026-10-26T19:31:59.188534Z","end":"2026-10-26T19:31:59.306995Z","steps":["trace[628960275] 'range keys from in-memory index tree' (duration: 117.968421ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:31:59.307049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.265208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-26T19:31:59.307149Z","caller":"traceutil/trace.go:171","msg":"trace[1607099567] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5866; }","duration":"225.446222ms","start":"2026-10-26T19:31:59.08168Z","end":"2026-10-26T19:31:59.307126Z","steps":["trace[1607099567] 'range keys from in-memory index tree' (duration: 225.025913ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:31:59.307256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.147531ms","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-10-26T19:31:59.307347Z","caller":"traceutil/trace.go:171","msg":"trace[117849517] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5866; }","duration":"192.306434ms","start":"2026-10-26T19:31:59.11502Z","end":"2026-10-26T19:31:59.307326Z","steps":["trace[117849517] 'range keys from in-memory index tree' (duration: 191.793724ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:32:11.619764Z","caller":"traceutil/trace.go:171","msg":"trace[1777964793] transaction","detail":"{read_only:false; response_revision:6030; number_of_response:1; }","duration":"172.588824ms","start":"2026-10-26T19:32:11.447147Z","end":"2026-10-26T19:32:11.619736Z","steps":["trace[1777964793] 'process raft request' (duration: 172.306078ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:32:11.620036Z","caller":"traceutil/trace.go:171","msg":"trace[123942747] transaction","detail":"{read_only:false; response_revision:6031; number_of_response:1; }","duration":"172.658045ms","start":"2026-10-26T19:32:11.447357Z","end":"2026-10-26T19:32:11.620015Z","steps":["trace[123942747] 'process raft request' (duration: 172.303898ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:32:11.620066Z","caller":"traceutil/trace.go:171","msg":"trace[1434298844] linearizableReadLoop","detail":"{readStateIndex:6255; appliedIndex:6253; }","duration":"172.85442ms","start":"2026-10-26T19:32:11.447185Z","end":"2026-10-26T19:32:11.620039Z","steps":["trace[1434298844] 'read index received' (duration: 15.58886ms)","trace[1434298844] 'applied index is now lower than readState.Index' (duration: 157.26443ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:32:11.62018Z","caller":"traceutil/trace.go:171","msg":"trace[1859538796] transaction","detail":"{read_only:false; response_revision:6032; number_of_response:1; }","duration":"172.604844ms","start":"2026-10-26T19:32:11.447563Z","end":"2026-10-26T19:32:11.620168Z","steps":["trace[1859538796] 'process raft request' (duration: 172.37569ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:32:11.620286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.071734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-0a7fa9b9-3b5e-46e9-a4c2-235676412da0\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-10-26T19:32:11.620337Z","caller":"traceutil/trace.go:171","msg":"trace[2135118675] range","detail":"{range_begin:/registry/persistentvolumes/pvc-0a7fa9b9-3b5e-46e9-a4c2-235676412da0; range_end:; response_count:1; response_revision:6032; }","duration":"173.182335ms","start":"2026-10-26T19:32:11.44714Z","end":"2026-10-26T19:32:11.620323Z","steps":["trace[2135118675] 'agreement among raft nodes before linearized reading' (duration: 172.992481ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:32:53.087349Z","caller":"traceutil/trace.go:171","msg":"trace[1159326416] transaction","detail":"{read_only:false; response_revision:6382; number_of_response:1; }","duration":"110.236284ms","start":"2026-10-26T19:32:52.977083Z","end":"2026-10-26T19:32:53.087319Z","steps":["trace[1159326416] 'process raft request' (duration: 110.019069ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:32:53.375413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.297937ms","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-10-26T19:32:53.375514Z","caller":"traceutil/trace.go:171","msg":"trace[1349462175] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6382; }","duration":"120.46439ms","start":"2026-10-26T19:32:53.255024Z","end":"2026-10-26T19:32:53.375488Z","steps":["trace[1349462175] 'range keys from in-memory index tree' (duration: 120.077873ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:32:53.375604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.538524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-10-26T19:32:53.375857Z","caller":"traceutil/trace.go:171","msg":"trace[1781745592] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:6382; }","duration":"198.774968ms","start":"2026-10-26T19:32:53.176986Z","end":"2026-10-26T19:32:53.375761Z","steps":["trace[1781745592] 'range keys from in-memory index tree' (duration: 198.281299ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:32:53.666123Z","caller":"traceutil/trace.go:171","msg":"trace[512857781] linearizableReadLoop","detail":"{readStateIndex:6619; appliedIndex:6618; }","duration":"129.588025ms","start":"2026-10-26T19:32:53.536499Z","end":"2026-10-26T19:32:53.666087Z","steps":["trace[512857781] 'read index received' (duration: 129.284179ms)","trace[512857781] 'applied index is now lower than readState.Index' (duration: 302.276µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:32:53.666278Z","caller":"traceutil/trace.go:171","msg":"trace[1788191390] transaction","detail":"{read_only:false; response_revision:6384; number_of_response:1; }","duration":"192.234032ms","start":"2026-10-26T19:32:53.47401Z","end":"2026-10-26T19:32:53.666244Z","steps":["trace[1788191390] 'process raft request' (duration: 191.820074ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:32:53.666433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.907042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.140\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-10-26T19:32:53.66649Z","caller":"traceutil/trace.go:171","msg":"trace[177110710] range","detail":"{range_begin:/registry/masterleases/162.253.55.140; range_end:; response_count:1; response_revision:6384; }","duration":"130.031074ms","start":"2026-10-26T19:32:53.536443Z","end":"2026-10-26T19:32:53.666474Z","steps":["trace[177110710] 'agreement among raft nodes before linearized reading' (duration: 129.783049ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:32:53.803297Z","caller":"traceutil/trace.go:171","msg":"trace[1159026738] linearizableReadLoop","detail":"{readStateIndex:6621; appliedIndex:6620; }","duration":"108.152723ms","start":"2026-10-26T19:32:53.695113Z","end":"2026-10-26T19:32:53.803265Z","steps":["trace[1159026738] 'read index received' (duration: 14.901808ms)","trace[1159026738] 'applied index is now lower than readState.Index' (duration: 93.249085ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:32:53.803515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.372747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-26T19:32:53.803622Z","caller":"traceutil/trace.go:171","msg":"trace[396297908] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6385; }","duration":"108.49466ms","start":"2026-10-26T19:32:53.695107Z","end":"2026-10-26T19:32:53.803602Z","steps":["trace[396297908] 'agreement among raft nodes before linearized reading' (duration: 108.256905ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:32:53.938583Z","caller":"traceutil/trace.go:171","msg":"trace[1375094020] linearizableReadLoop","detail":"{readStateIndex:6623; appliedIndex:6622; }","duration":"100.632908ms","start":"2026-10-26T19:32:53.837918Z","end":"2026-10-26T19:32:53.938551Z","steps":["trace[1375094020] 'read index received' (duration: 94.793515ms)","trace[1375094020] 'applied index is now lower than readState.Index' (duration: 5.837733ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:32:53.938676Z","caller":"traceutil/trace.go:171","msg":"trace[1523474095] transaction","detail":"{read_only:false; response_revision:6387; number_of_response:1; }","duration":"130.529815ms","start":"2026-10-26T19:32:53.808115Z","end":"2026-10-26T19:32:53.938645Z","steps":["trace[1523474095] 'process raft request' (duration: 124.631141ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:32:53.938965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.023405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-10-26T19:32:53.939039Z","caller":"traceutil/trace.go:171","msg":"trace[1276541111] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:6387; }","duration":"101.153648ms","start":"2026-10-26T19:32:53.837863Z","end":"2026-10-26T19:32:53.939017Z","steps":["trace[1276541111] 'agreement among raft nodes before linearized reading' (duration: 100.821041ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:36:40.157555Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5542} {"level":"info","ts":"2026-10-26T19:36:40.258739Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5542,"took":"98.610069ms","hash":1491650528,"current-db-size-bytes":54550528,"current-db-size":"55 MB","current-db-size-in-use-bytes":29249536,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-26T19:36:40.258855Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1491650528,"revision":5542,"compact-revision":2958} {"level":"info","ts":"2026-10-26T19:38:16.090095Z","caller":"traceutil/trace.go:171","msg":"trace[2100239914] linearizableReadLoop","detail":"{readStateIndex:9071; appliedIndex:9070; }","duration":"261.71721ms","start":"2026-10-26T19:38:15.828343Z","end":"2026-10-26T19:38:16.09006Z","steps":["trace[2100239914] 'read index received' (duration: 261.495745ms)","trace[2100239914] 'applied index is now lower than readState.Index' (duration: 219.945µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:38:16.090145Z","caller":"traceutil/trace.go:171","msg":"trace[1304320220] transaction","detail":"{read_only:false; response_revision:8757; number_of_response:1; }","duration":"263.76032ms","start":"2026-10-26T19:38:15.826343Z","end":"2026-10-26T19:38:16.090103Z","steps":["trace[1304320220] 'process raft request' (duration: 263.509015ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:38:16.090393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.030477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-10-26T19:38:16.090455Z","caller":"traceutil/trace.go:171","msg":"trace[679779177] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8757; }","duration":"262.176679ms","start":"2026-10-26T19:38:15.828259Z","end":"2026-10-26T19:38:16.090436Z","steps":["trace[679779177] 'agreement among raft nodes before linearized reading' (duration: 261.942485ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:38:16.165266Z","caller":"traceutil/trace.go:171","msg":"trace[263731261] transaction","detail":"{read_only:false; response_revision:8758; number_of_response:1; }","duration":"336.835006ms","start":"2026-10-26T19:38:15.828399Z","end":"2026-10-26T19:38:16.165235Z","steps":["trace[263731261] 'process raft request' (duration: 336.594872ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:38:16.16548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:38:15.828358Z","time spent":"337.01215ms","remote":"127.0.0.1:35550","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-10-26T19:38:16.165623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.371582ms","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-10-26T19:38:16.165651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.213012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-10-26T19:38:16.165645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.723959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T19:38:16.165703Z","caller":"traceutil/trace.go:171","msg":"trace[948228522] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8759; }","duration":"289.495135ms","start":"2026-10-26T19:38:15.87619Z","end":"2026-10-26T19:38:16.165685Z","steps":["trace[948228522] 'agreement among raft nodes before linearized reading' (duration: 289.278551ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:38:16.165714Z","caller":"traceutil/trace.go:171","msg":"trace[1894690963] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8759; }","duration":"286.302173ms","start":"2026-10-26T19:38:15.879395Z","end":"2026-10-26T19:38:16.165697Z","steps":["trace[1894690963] 'agreement among raft nodes before linearized reading' (duration: 286.104759ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:38:16.165753Z","caller":"traceutil/trace.go:171","msg":"trace[1879172065] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:8759; }","duration":"329.920563ms","start":"2026-10-26T19:38:15.835811Z","end":"2026-10-26T19:38:16.165732Z","steps":["trace[1879172065] 'agreement among raft nodes before linearized reading' (duration: 329.724949ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:38:16.16581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:38:15.835791Z","time spent":"330.006914ms","remote":"127.0.0.1:40942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true "} {"level":"info","ts":"2026-10-26T19:38:16.1667Z","caller":"traceutil/trace.go:171","msg":"trace[1068737949] transaction","detail":"{read_only:false; response_revision:8759; number_of_response:1; }","duration":"274.2205ms","start":"2026-10-26T19:38:15.891765Z","end":"2026-10-26T19:38:16.165986Z","steps":["trace[1068737949] 'process raft request' (duration: 273.405714ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:38:27.348376Z","caller":"traceutil/trace.go:171","msg":"trace[103726887] transaction","detail":"{read_only:false; response_revision:8817; number_of_response:1; }","duration":"199.569803ms","start":"2026-10-26T19:38:27.148775Z","end":"2026-10-26T19:38:27.348345Z","steps":["trace[103726887] 'process raft request' (duration: 199.079133ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:38:58.610793Z","caller":"traceutil/trace.go:171","msg":"trace[440381722] transaction","detail":"{read_only:false; response_revision:9036; number_of_response:1; }","duration":"187.263816ms","start":"2026-10-26T19:38:58.423506Z","end":"2026-10-26T19:38:58.61077Z","steps":["trace[440381722] 'process raft request' (duration: 187.120303ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:38:58.611238Z","caller":"traceutil/trace.go:171","msg":"trace[670260823] linearizableReadLoop","detail":"{readStateIndex:9361; appliedIndex:9361; }","duration":"173.746326ms","start":"2026-10-26T19:38:58.437481Z","end":"2026-10-26T19:38:58.611228Z","steps":["trace[670260823] 'read index received' (duration: 173.743236ms)","trace[670260823] 'applied index is now lower than readState.Index' (duration: 2.31µs)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:38:58.611392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.891719ms","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-10-26T19:38:58.611429Z","caller":"traceutil/trace.go:171","msg":"trace[2006266652] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9036; }","duration":"173.985901ms","start":"2026-10-26T19:38:58.437434Z","end":"2026-10-26T19:38:58.61142Z","steps":["trace[2006266652] 'agreement among raft nodes before linearized reading' (duration: 173.858858ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:38:58.873391Z","caller":"traceutil/trace.go:171","msg":"trace[1110826710] linearizableReadLoop","detail":"{readStateIndex:9362; appliedIndex:9361; }","duration":"262.077736ms","start":"2026-10-26T19:38:58.611273Z","end":"2026-10-26T19:38:58.87335Z","steps":["trace[1110826710] 'read index received' (duration: 177.998468ms)","trace[1110826710] 'applied index is now lower than readState.Index' (duration: 84.077718ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:38:58.873487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.957331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-10-26T19:38:58.87361Z","caller":"traceutil/trace.go:171","msg":"trace[2080499909] transaction","detail":"{read_only:false; response_revision:9037; number_of_response:1; }","duration":"435.508406ms","start":"2026-10-26T19:38:58.438046Z","end":"2026-10-26T19:38:58.873554Z","steps":["trace[2080499909] 'process raft request' (duration: 351.081071ms)","trace[2080499909] 'compare' (duration: 83.964507ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:38:58.873752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.550487ms","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-10-26T19:38:58.873811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.783446ms","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-10-26T19:38:58.873871Z","caller":"traceutil/trace.go:171","msg":"trace[273560996] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9037; }","duration":"353.652709ms","start":"2026-10-26T19:38:58.52017Z","end":"2026-10-26T19:38:58.873823Z","steps":["trace[273560996] 'agreement among raft nodes before linearized reading' (duration: 353.397094ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:38:58.873904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:38:58.43803Z","time spent":"435.7277ms","remote":"127.0.0.1:35550","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-10-26T19:38:58.873927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:38:58.520142Z","time spent":"353.773222ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-10-26T19:38:58.873958Z","caller":"traceutil/trace.go:171","msg":"trace[732545852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9037; }","duration":"402.941369ms","start":"2026-10-26T19:38:58.470964Z","end":"2026-10-26T19:38:58.873905Z","steps":["trace[732545852] 'agreement among raft nodes before linearized reading' (duration: 402.620042ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:38:58.874012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:38:58.470955Z","time spent":"403.048731ms","remote":"127.0.0.1:35550","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-10-26T19:38:58.874347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.515585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bgv7h\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-10-26T19:38:58.874434Z","caller":"traceutil/trace.go:171","msg":"trace[2107457763] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bgv7h; range_end:; response_count:1; response_revision:9037; }","duration":"316.338492ms","start":"2026-10-26T19:38:58.558072Z","end":"2026-10-26T19:38:58.874411Z","steps":["trace[2107457763] 'agreement among raft nodes before linearized reading' (duration: 315.445144ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:38:58.87444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.033205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-26T19:38:58.874491Z","caller":"traceutil/trace.go:171","msg":"trace[695042431] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9037; }","duration":"344.085296ms","start":"2026-10-26T19:38:58.530391Z","end":"2026-10-26T19:38:58.874476Z","steps":["trace[695042431] 'agreement among raft nodes before linearized reading' (duration: 343.927413ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:38:58.874496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:38:58.558015Z","time spent":"316.466194ms","remote":"127.0.0.1:35504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6554,"request content":"key:\"/registry/pods/openstack/keepalived-bgv7h\" "} {"level":"warn","ts":"2026-10-26T19:38:58.874532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:38:58.530381Z","time spent":"344.143207ms","remote":"127.0.0.1:35550","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":"info","ts":"2026-10-26T19:38:58.873559Z","caller":"traceutil/trace.go:171","msg":"trace[344069386] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:9037; }","duration":"292.052924ms","start":"2026-10-26T19:38:58.581492Z","end":"2026-10-26T19:38:58.873545Z","steps":["trace[344069386] 'agreement among raft nodes before linearized reading' (duration: 291.87336ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:38:58.877143Z","caller":"traceutil/trace.go:171","msg":"trace[2058789408] transaction","detail":"{read_only:false; response_revision:9038; number_of_response:1; }","duration":"260.840043ms","start":"2026-10-26T19:38:58.61626Z","end":"2026-10-26T19:38:58.8771Z","steps":["trace[2058789408] 'process raft request' (duration: 260.65121ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:38:58.877639Z","caller":"traceutil/trace.go:171","msg":"trace[436053932] transaction","detail":"{read_only:false; response_revision:9039; number_of_response:1; }","duration":"219.337074ms","start":"2026-10-26T19:38:58.658281Z","end":"2026-10-26T19:38:58.877618Z","steps":["trace[436053932] 'process raft request' (duration: 218.716181ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:38:58.883053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.782398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-26T19:38:58.883117Z","caller":"traceutil/trace.go:171","msg":"trace[680847514] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:9040; }","duration":"225.90349ms","start":"2026-10-26T19:38:58.657196Z","end":"2026-10-26T19:38:58.883099Z","steps":["trace[680847514] 'agreement among raft nodes before linearized reading' (duration: 225.694506ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:39:01.718796Z","caller":"traceutil/trace.go:171","msg":"trace[1109864945] transaction","detail":"{read_only:false; response_revision:9055; number_of_response:1; }","duration":"121.713983ms","start":"2026-10-26T19:39:01.597046Z","end":"2026-10-26T19:39:01.718761Z","steps":["trace[1109864945] 'process raft request' (duration: 106.363998ms)","trace[1109864945] 'compare' (duration: 15.187142ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:39:12.703872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.08803ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T19:39:12.704729Z","caller":"traceutil/trace.go:171","msg":"trace[1019775691] transaction","detail":"{read_only:false; number_of_response:1; response_revision:9118; }","duration":"172.796177ms","start":"2026-10-26T19:39:12.531915Z","end":"2026-10-26T19:39:12.704711Z","steps":["trace[1019775691] 'process raft request' (duration: 172.732115ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:39:12.704924Z","caller":"traceutil/trace.go:171","msg":"trace[1615941484] transaction","detail":"{read_only:false; response_revision:9117; number_of_response:1; }","duration":"173.022901ms","start":"2026-10-26T19:39:12.531872Z","end":"2026-10-26T19:39:12.704895Z","steps":["trace[1615941484] 'process raft request' (duration: 48.789269ms)","trace[1615941484] 'compare' (duration: 122.984778ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:39:12.93657Z","caller":"traceutil/trace.go:171","msg":"trace[1161469802] transaction","detail":"{read_only:false; response_revision:9119; number_of_response:1; }","duration":"274.967245ms","start":"2026-10-26T19:39:12.661585Z","end":"2026-10-26T19:39:12.936552Z","steps":["trace[1161469802] 'process raft request' (duration: 239.736577ms)","trace[1161469802] 'compare' (duration: 34.955502ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:39:12.936559Z","caller":"traceutil/trace.go:171","msg":"trace[994939090] linearizableReadLoop","detail":"{readStateIndex:9448; appliedIndex:9446; }","duration":"227.498531ms","start":"2026-10-26T19:39:12.709029Z","end":"2026-10-26T19:39:12.936527Z","steps":["trace[994939090] 'read index received' (duration: 192.299304ms)","trace[994939090] 'applied index is now lower than readState.Index' (duration: 35.198157ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:39:12.936766Z","caller":"traceutil/trace.go:171","msg":"trace[1700675978] transaction","detail":"{read_only:false; response_revision:9120; number_of_response:1; }","duration":"268.654593ms","start":"2026-10-26T19:39:12.668088Z","end":"2026-10-26T19:39:12.936743Z","steps":["trace[1700675978] 'process raft request' (duration: 268.370197ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:39:12.936801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.748086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-hf6dz\" ","response":"range_response_count:1 size:4766"} {"level":"warn","ts":"2026-10-26T19:39:12.937047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.053902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-hf6dz\" ","response":"range_response_count:1 size:2802"} {"level":"info","ts":"2026-10-26T19:39:12.937077Z","caller":"traceutil/trace.go:171","msg":"trace[1543944127] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-hf6dz; range_end:; response_count:1; response_revision:9120; }","duration":"227.124884ms","start":"2026-10-26T19:39:12.709941Z","end":"2026-10-26T19:39:12.937066Z","steps":["trace[1543944127] 'agreement among raft nodes before linearized reading' (duration: 227.039762ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:39:12.937079Z","caller":"traceutil/trace.go:171","msg":"trace[1398433122] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-hf6dz; range_end:; response_count:1; response_revision:9120; }","duration":"228.049302ms","start":"2026-10-26T19:39:12.709012Z","end":"2026-10-26T19:39:12.937061Z","steps":["trace[1398433122] 'agreement among raft nodes before linearized reading' (duration: 227.601983ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:39:27.141225Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002591.wal"} {"level":"info","ts":"2026-10-26T19:40:12.594087Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cf809824ab95ac81","local-member-applied-index":10005,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-26T19:40:12.611949Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10005} {"level":"info","ts":"2026-10-26T19:40:12.612097Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5005} {"level":"info","ts":"2026-10-26T19:40:27.593496Z","caller":"traceutil/trace.go:171","msg":"trace[918246472] linearizableReadLoop","detail":"{readStateIndex:10241; appliedIndex:10240; }","duration":"106.053418ms","start":"2026-10-26T19:40:27.487419Z","end":"2026-10-26T19:40:27.593472Z","steps":["trace[918246472] 'read index received' (duration: 105.784584ms)","trace[918246472] 'applied index is now lower than readState.Index' (duration: 267.174µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:40:27.593579Z","caller":"traceutil/trace.go:171","msg":"trace[213327270] transaction","detail":"{read_only:false; response_revision:9891; number_of_response:1; }","duration":"112.807198ms","start":"2026-10-26T19:40:27.48073Z","end":"2026-10-26T19:40:27.593537Z","steps":["trace[213327270] 'process raft request' (duration: 112.575784ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:40:27.593895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.419335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-26T19:40:27.593968Z","caller":"traceutil/trace.go:171","msg":"trace[533641050] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9891; }","duration":"106.593309ms","start":"2026-10-26T19:40:27.487354Z","end":"2026-10-26T19:40:27.593947Z","steps":["trace[533641050] 'agreement among raft nodes before linearized reading' (duration: 106.274612ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:41:40.164024Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7994} {"level":"info","ts":"2026-10-26T19:41:40.27508Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7994,"took":"108.845082ms","hash":2867259982,"current-db-size-bytes":54550528,"current-db-size":"55 MB","current-db-size-in-use-bytes":25141248,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-10-26T19:41:40.275154Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2867259982,"revision":7994,"compact-revision":5542} {"level":"info","ts":"2026-10-26T19:46:21.023953Z","caller":"traceutil/trace.go:171","msg":"trace[968230794] linearizableReadLoop","detail":"{readStateIndex:12840; appliedIndex:12838; }","duration":"191.427358ms","start":"2026-10-26T19:46:20.832501Z","end":"2026-10-26T19:46:21.023928Z","steps":["trace[968230794] 'read index received' (duration: 191.298337ms)","trace[968230794] 'applied index is now lower than readState.Index' (duration: 128.241µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:46:21.024035Z","caller":"traceutil/trace.go:171","msg":"trace[692095426] transaction","detail":"{read_only:false; response_revision:12407; number_of_response:1; }","duration":"314.935527ms","start":"2026-10-26T19:46:20.709062Z","end":"2026-10-26T19:46:21.023998Z","steps":["trace[692095426] 'process raft request' (duration: 314.666502ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:46:21.024212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.687923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/cinder-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-10-26T19:46:21.024253Z","caller":"traceutil/trace.go:171","msg":"trace[840316940] range","detail":"{range_begin:/registry/services/endpoints/openstack/cinder-api; range_end:; response_count:1; response_revision:12408; }","duration":"191.787396ms","start":"2026-10-26T19:46:20.832456Z","end":"2026-10-26T19:46:21.024243Z","steps":["trace[840316940] 'agreement among raft nodes before linearized reading' (duration: 191.642623ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:46:21.024077Z","caller":"traceutil/trace.go:171","msg":"trace[1552163111] transaction","detail":"{read_only:false; response_revision:12408; number_of_response:1; }","duration":"305.680418ms","start":"2026-10-26T19:46:20.718385Z","end":"2026-10-26T19:46:21.024065Z","steps":["trace[1552163111] 'process raft request' (duration: 305.504835ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:46:21.024427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:46:20.718356Z","time spent":"305.958554ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T19:46:21.024487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:46:20.70903Z","time spent":"315.226442ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T19:46:21.037041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.429018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5079"} {"level":"info","ts":"2026-10-26T19:46:21.037101Z","caller":"traceutil/trace.go:171","msg":"trace[119830220] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:12409; }","duration":"204.527541ms","start":"2026-10-26T19:46:20.832558Z","end":"2026-10-26T19:46:21.037085Z","steps":["trace[119830220] 'agreement among raft nodes before linearized reading' (duration: 204.348627ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:46:21.037082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.283236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T19:46:21.037169Z","caller":"traceutil/trace.go:171","msg":"trace[1697669783] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:12409; }","duration":"204.437829ms","start":"2026-10-26T19:46:20.832711Z","end":"2026-10-26T19:46:21.037149Z","steps":["trace[1697669783] 'agreement among raft nodes before linearized reading' (duration: 204.276116ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:46:21.037179Z","caller":"traceutil/trace.go:171","msg":"trace[1675950074] transaction","detail":"{read_only:false; response_revision:12409; number_of_response:1; }","duration":"190.856109ms","start":"2026-10-26T19:46:20.846294Z","end":"2026-10-26T19:46:21.037151Z","steps":["trace[1675950074] 'process raft request' (duration: 190.461681ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:46:21.037304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.49192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-26T19:46:21.037347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.590151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T19:46:21.037366Z","caller":"traceutil/trace.go:171","msg":"trace[963018035] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:12409; }","duration":"204.623863ms","start":"2026-10-26T19:46:20.832726Z","end":"2026-10-26T19:46:21.03735Z","steps":["trace[963018035] 'agreement among raft nodes before linearized reading' (duration: 204.539101ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:46:21.037418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.775196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T19:46:21.037447Z","caller":"traceutil/trace.go:171","msg":"trace[1919080729] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:12409; }","duration":"204.630412ms","start":"2026-10-26T19:46:20.832744Z","end":"2026-10-26T19:46:21.037375Z","steps":["trace[1919080729] 'agreement among raft nodes before linearized reading' (duration: 204.564661ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:46:21.037481Z","caller":"traceutil/trace.go:171","msg":"trace[1787523715] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:12409; }","duration":"204.853717ms","start":"2026-10-26T19:46:20.832611Z","end":"2026-10-26T19:46:21.037465Z","steps":["trace[1787523715] 'agreement among raft nodes before linearized reading' (duration: 204.763055ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:46:40.172579Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10396} {"level":"info","ts":"2026-10-26T19:46:40.260664Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10396,"took":"85.312615ms","hash":3704274128,"current-db-size-bytes":54550528,"current-db-size":"55 MB","current-db-size-in-use-bytes":26185728,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-26T19:46:40.260762Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3704274128,"revision":10396,"compact-revision":7994} {"level":"info","ts":"2026-10-26T19:51:40.187071Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12563} {"level":"info","ts":"2026-10-26T19:51:40.274997Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12563,"took":"84.841666ms","hash":822006605,"current-db-size-bytes":54550528,"current-db-size":"55 MB","current-db-size-in-use-bytes":27918336,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-26T19:51:40.275091Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":822006605,"revision":12563,"compact-revision":10396} {"level":"warn","ts":"2026-10-26T19:52:21.617704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.021362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bgv7h\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-10-26T19:52:21.617803Z","caller":"traceutil/trace.go:171","msg":"trace[740198548] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bgv7h; range_end:; response_count:1; response_revision:14854; }","duration":"180.132194ms","start":"2026-10-26T19:52:21.437648Z","end":"2026-10-26T19:52:21.61778Z","steps":["trace[740198548] 'range keys from in-memory index tree' (duration: 179.847619ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:52:42.426561Z","caller":"traceutil/trace.go:171","msg":"trace[1311913623] transaction","detail":"{read_only:false; response_revision:14966; number_of_response:1; }","duration":"103.068896ms","start":"2026-10-26T19:52:42.32346Z","end":"2026-10-26T19:52:42.426529Z","steps":["trace[1311913623] 'process raft request' (duration: 102.840491ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:53:00.744241Z","caller":"traceutil/trace.go:171","msg":"trace[39928794] linearizableReadLoop","detail":"{readStateIndex:15603; appliedIndex:15602; }","duration":"204.222475ms","start":"2026-10-26T19:53:00.539987Z","end":"2026-10-26T19:53:00.744209Z","steps":["trace[39928794] 'read index received' (duration: 204.142404ms)","trace[39928794] 'applied index is now lower than readState.Index' (duration: 78.901µs)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:53:00.744553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.546492ms","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-10-26T19:53:00.744679Z","caller":"traceutil/trace.go:171","msg":"trace[195825773] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15075; }","duration":"204.728204ms","start":"2026-10-26T19:53:00.539935Z","end":"2026-10-26T19:53:00.744663Z","steps":["trace[195825773] 'agreement among raft nodes before linearized reading' (duration: 204.409159ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:53:00.744883Z","caller":"traceutil/trace.go:171","msg":"trace[1947628125] transaction","detail":"{read_only:false; response_revision:15075; number_of_response:1; }","duration":"241.912219ms","start":"2026-10-26T19:53:00.502379Z","end":"2026-10-26T19:53:00.744291Z","steps":["trace[1947628125] 'process raft request' (duration: 241.658294ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:53:00.781906Z","caller":"traceutil/trace.go:171","msg":"trace[914130569] transaction","detail":"{read_only:false; response_revision:15076; number_of_response:1; }","duration":"227.279098ms","start":"2026-10-26T19:53:00.554589Z","end":"2026-10-26T19:53:00.781868Z","steps":["trace[914130569] 'process raft request' (duration: 222.187581ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:53:00.782066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.296398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-10-26T19:53:00.782153Z","caller":"traceutil/trace.go:171","msg":"trace[466868473] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:15077; }","duration":"215.462041ms","start":"2026-10-26T19:53:00.566666Z","end":"2026-10-26T19:53:00.782128Z","steps":["trace[466868473] 'agreement among raft nodes before linearized reading' (duration: 215.173176ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:53:25.842834Z","caller":"traceutil/trace.go:171","msg":"trace[328649948] linearizableReadLoop","detail":"{readStateIndex:15944; appliedIndex:15943; }","duration":"174.112886ms","start":"2026-10-26T19:53:25.668703Z","end":"2026-10-26T19:53:25.842816Z","steps":["trace[328649948] 'read index received' (duration: 173.908252ms)","trace[328649948] 'applied index is now lower than readState.Index' (duration: 203.914µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:53:25.842912Z","caller":"traceutil/trace.go:171","msg":"trace[801728217] transaction","detail":"{read_only:false; response_revision:15402; number_of_response:1; }","duration":"415.213476ms","start":"2026-10-26T19:53:25.427676Z","end":"2026-10-26T19:53:25.842889Z","steps":["trace[801728217] 'process raft request' (duration: 414.992362ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:53:25.843037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:53:25.427645Z","time spent":"415.314337ms","remote":"127.0.0.1:35504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3742,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T19:53:25.843272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.558414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-10-26T19:53:25.843321Z","caller":"traceutil/trace.go:171","msg":"trace[1614042249] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:15402; }","duration":"174.650696ms","start":"2026-10-26T19:53:25.668656Z","end":"2026-10-26T19:53:25.843307Z","steps":["trace[1614042249] 'agreement among raft nodes before linearized reading' (duration: 174.272109ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:53:25.972601Z","caller":"traceutil/trace.go:171","msg":"trace[45460573] linearizableReadLoop","detail":"{readStateIndex:15946; appliedIndex:15945; }","duration":"105.337448ms","start":"2026-10-26T19:53:25.867227Z","end":"2026-10-26T19:53:25.972564Z","steps":["trace[45460573] 'read index received' (duration: 69.024212ms)","trace[45460573] 'applied index is now lower than readState.Index' (duration: 36.312276ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:53:25.972626Z","caller":"traceutil/trace.go:171","msg":"trace[1980957114] transaction","detail":"{read_only:false; response_revision:15404; number_of_response:1; }","duration":"108.869866ms","start":"2026-10-26T19:53:25.863721Z","end":"2026-10-26T19:53:25.972591Z","steps":["trace[1980957114] 'process raft request' (duration: 72.634642ms)","trace[1980957114] 'compare' (duration: 36.02727ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:53:25.972884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.641634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-nova-server\" ","response":"range_response_count:1 size:9709"} {"level":"info","ts":"2026-10-26T19:53:25.972966Z","caller":"traceutil/trace.go:171","msg":"trace[1787193042] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-nova-server; range_end:; response_count:1; response_revision:15404; }","duration":"105.776466ms","start":"2026-10-26T19:53:25.867169Z","end":"2026-10-26T19:53:25.972945Z","steps":["trace[1787193042] 'agreement among raft nodes before linearized reading' (duration: 105.534252ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:54:51.440365Z","caller":"traceutil/trace.go:171","msg":"trace[388218267] transaction","detail":"{read_only:false; response_revision:16207; number_of_response:1; }","duration":"199.720457ms","start":"2026-10-26T19:54:51.240604Z","end":"2026-10-26T19:54:51.440324Z","steps":["trace[388218267] 'process raft request' (duration: 192.536199ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:54:51.440385Z","caller":"traceutil/trace.go:171","msg":"trace[173581837] transaction","detail":"{read_only:false; response_revision:16208; number_of_response:1; }","duration":"198.513454ms","start":"2026-10-26T19:54:51.241841Z","end":"2026-10-26T19:54:51.440354Z","steps":["trace[173581837] 'process raft request' (duration: 198.368201ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:54:51.510854Z","caller":"traceutil/trace.go:171","msg":"trace[293032987] linearizableReadLoop","detail":"{readStateIndex:16772; appliedIndex:16769; }","duration":"157.292355ms","start":"2026-10-26T19:54:51.353534Z","end":"2026-10-26T19:54:51.510826Z","steps":["trace[293032987] 'read index received' (duration: 79.593185ms)","trace[293032987] 'applied index is now lower than readState.Index' (duration: 77.69786ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:54:51.510923Z","caller":"traceutil/trace.go:171","msg":"trace[390180385] transaction","detail":"{read_only:false; response_revision:16209; number_of_response:1; }","duration":"189.745727ms","start":"2026-10-26T19:54:51.321148Z","end":"2026-10-26T19:54:51.510893Z","steps":["trace[390180385] 'process raft request' (duration: 189.548853ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:54:51.511116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.562129ms","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-10-26T19:54:51.511198Z","caller":"traceutil/trace.go:171","msg":"trace[113654726] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:16209; }","duration":"157.692301ms","start":"2026-10-26T19:54:51.353483Z","end":"2026-10-26T19:54:51.511175Z","steps":["trace[113654726] 'agreement among raft nodes before linearized reading' (duration: 157.437538ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:54:51.784938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.687ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T19:54:51.78517Z","caller":"traceutil/trace.go:171","msg":"trace[810916783] transaction","detail":"{read_only:false; response_revision:16211; number_of_response:1; }","duration":"206.972296ms","start":"2026-10-26T19:54:51.578175Z","end":"2026-10-26T19:54:51.785147Z","steps":["trace[810916783] 'process raft request' (duration: 206.887574ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:54:51.785198Z","caller":"traceutil/trace.go:171","msg":"trace[642451263] linearizableReadLoop","detail":"{readStateIndex:16773; appliedIndex:16772; }","duration":"259.865601ms","start":"2026-10-26T19:54:51.525313Z","end":"2026-10-26T19:54:51.785179Z","steps":["trace[642451263] 'read index received' (duration: 87.859764ms)","trace[642451263] 'applied index is now lower than readState.Index' (duration: 172.004397ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:54:51.785282Z","caller":"traceutil/trace.go:171","msg":"trace[1450158514] transaction","detail":"{read_only:false; response_revision:16210; number_of_response:1; }","duration":"261.187095ms","start":"2026-10-26T19:54:51.524082Z","end":"2026-10-26T19:54:51.785269Z","steps":["trace[1450158514] 'process raft request' (duration: 89.061637ms)","trace[1450158514] 'compare' (duration: 170.791402ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:54:51.785482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.91516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-10-26T19:54:51.785546Z","caller":"traceutil/trace.go:171","msg":"trace[136014403] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16211; }","duration":"260.034073ms","start":"2026-10-26T19:54:51.525495Z","end":"2026-10-26T19:54:51.785529Z","steps":["trace[136014403] 'agreement among raft nodes before linearized reading' (duration: 259.803179ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:54:51.785661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.341759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-10-26T19:54:51.78571Z","caller":"traceutil/trace.go:171","msg":"trace[101155664] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16211; }","duration":"260.42005ms","start":"2026-10-26T19:54:51.525277Z","end":"2026-10-26T19:54:51.785697Z","steps":["trace[101155664] 'agreement among raft nodes before linearized reading' (duration: 260.320598ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:54:52.174914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.506463ms","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-10-26T19:54:52.174999Z","caller":"traceutil/trace.go:171","msg":"trace[1738116871] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:16211; }","duration":"176.718406ms","start":"2026-10-26T19:54:51.998258Z","end":"2026-10-26T19:54:52.174977Z","steps":["trace[1738116871] 'count revisions from in-memory index tree' (duration: 176.391549ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:54:52.59246Z","caller":"traceutil/trace.go:171","msg":"trace[974471514] linearizableReadLoop","detail":"{readStateIndex:16776; appliedIndex:16775; }","duration":"106.117904ms","start":"2026-10-26T19:54:52.486293Z","end":"2026-10-26T19:54:52.59241Z","steps":["trace[974471514] 'read index received' (duration: 86.586279ms)","trace[974471514] 'applied index is now lower than readState.Index' (duration: 19.530305ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:54:52.592602Z","caller":"traceutil/trace.go:171","msg":"trace[1820488136] transaction","detail":"{read_only:false; response_revision:16213; number_of_response:1; }","duration":"120.234284ms","start":"2026-10-26T19:54:52.472326Z","end":"2026-10-26T19:54:52.59256Z","steps":["trace[1820488136] 'process raft request' (duration: 100.567358ms)","trace[1820488136] 'compare' (duration: 19.242598ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:54:52.592737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.426159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-26T19:54:52.592783Z","caller":"traceutil/trace.go:171","msg":"trace[1852406019] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:16213; }","duration":"106.544582ms","start":"2026-10-26T19:54:52.486225Z","end":"2026-10-26T19:54:52.59277Z","steps":["trace[1852406019] 'agreement among raft nodes before linearized reading' (duration: 106.365708ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:56:40.194468Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14569} {"level":"info","ts":"2026-10-26T19:56:40.291357Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14569,"took":"93.849419ms","hash":2530217355,"current-db-size-bytes":54550528,"current-db-size":"55 MB","current-db-size-in-use-bytes":30625792,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-26T19:56:40.291452Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2530217355,"revision":14569,"compact-revision":12563} {"level":"info","ts":"2026-10-26T20:00:24.176613Z","caller":"traceutil/trace.go:171","msg":"trace[1012839318] linearizableReadLoop","detail":"{readStateIndex:19334; appliedIndex:19333; }","duration":"161.517897ms","start":"2026-10-26T20:00:24.015073Z","end":"2026-10-26T20:00:24.176591Z","steps":["trace[1012839318] 'read index received' (duration: 161.482597ms)","trace[1012839318] 'applied index is now lower than readState.Index' (duration: 34.34µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:00:24.176729Z","caller":"traceutil/trace.go:171","msg":"trace[2086359705] transaction","detail":"{read_only:false; response_revision:18688; number_of_response:1; }","duration":"162.630959ms","start":"2026-10-26T20:00:24.014088Z","end":"2026-10-26T20:00:24.176719Z","steps":["trace[2086359705] 'process raft request' (duration: 162.375524ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:00:24.17693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.870064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-l3-agent-default-hlgm6\" ","response":"range_response_count:1 size:18680"} {"level":"info","ts":"2026-10-26T20:00:24.17697Z","caller":"traceutil/trace.go:171","msg":"trace[1018410680] range","detail":"{range_begin:/registry/pods/openstack/neutron-l3-agent-default-hlgm6; range_end:; response_count:1; response_revision:18688; }","duration":"161.946846ms","start":"2026-10-26T20:00:24.015013Z","end":"2026-10-26T20:00:24.17696Z","steps":["trace[1018410680] 'agreement among raft nodes before linearized reading' (duration: 161.815424ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:00:24.187508Z","caller":"traceutil/trace.go:171","msg":"trace[1824491262] transaction","detail":"{read_only:false; response_revision:18689; number_of_response:1; }","duration":"123.550631ms","start":"2026-10-26T20:00:24.063933Z","end":"2026-10-26T20:00:24.187484Z","steps":["trace[1824491262] 'process raft request' (duration: 123.108402ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:00:24.188563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.259689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"} {"level":"info","ts":"2026-10-26T20:00:24.188616Z","caller":"traceutil/trace.go:171","msg":"trace[1615348727] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18689; }","duration":"108.32325ms","start":"2026-10-26T20:00:24.080279Z","end":"2026-10-26T20:00:24.188602Z","steps":["trace[1615348727] 'agreement among raft nodes before linearized reading' (duration: 108.189207ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:01:00.148733Z","caller":"traceutil/trace.go:171","msg":"trace[686112028] transaction","detail":"{read_only:false; response_revision:18935; number_of_response:1; }","duration":"112.930357ms","start":"2026-10-26T20:01:00.035766Z","end":"2026-10-26T20:01:00.148697Z","steps":["trace[686112028] 'process raft request' (duration: 99.684334ms)","trace[686112028] 'compare' (duration: 13.024679ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:01:02.531398Z","caller":"traceutil/trace.go:171","msg":"trace[160448922] transaction","detail":"{read_only:false; response_revision:18958; number_of_response:1; }","duration":"231.053495ms","start":"2026-10-26T20:01:02.30032Z","end":"2026-10-26T20:01:02.531374Z","steps":["trace[160448922] 'process raft request' (duration: 230.872111ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:01:02.555015Z","caller":"traceutil/trace.go:171","msg":"trace[926008378] transaction","detail":"{read_only:false; response_revision:18959; number_of_response:1; }","duration":"240.745331ms","start":"2026-10-26T20:01:02.314238Z","end":"2026-10-26T20:01:02.554984Z","steps":["trace[926008378] 'process raft request' (duration: 240.459165ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:01:10.157801Z","caller":"traceutil/trace.go:171","msg":"trace[980690081] linearizableReadLoop","detail":"{readStateIndex:19657; appliedIndex:19656; }","duration":"176.246008ms","start":"2026-10-26T20:01:09.981522Z","end":"2026-10-26T20:01:10.157768Z","steps":["trace[980690081] 'read index received' (duration: 175.902251ms)","trace[980690081] 'applied index is now lower than readState.Index' (duration: 342.427µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:01:10.158295Z","caller":"traceutil/trace.go:171","msg":"trace[641030543] transaction","detail":"{read_only:false; response_revision:19001; number_of_response:1; }","duration":"259.01337ms","start":"2026-10-26T20:01:09.899243Z","end":"2026-10-26T20:01:10.158257Z","steps":["trace[641030543] 'process raft request' (duration: 258.306406ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:01:10.158408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.867789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-9tnvs\" ","response":"range_response_count:1 size:9797"} {"level":"warn","ts":"2026-10-26T20:01:10.158426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.567021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-26T20:01:10.158477Z","caller":"traceutil/trace.go:171","msg":"trace[299687551] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-9tnvs; range_end:; response_count:1; response_revision:19001; }","duration":"176.987312ms","start":"2026-10-26T20:01:09.981467Z","end":"2026-10-26T20:01:10.158454Z","steps":["trace[299687551] 'agreement among raft nodes before linearized reading' (duration: 176.677806ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:01:10.158499Z","caller":"traceutil/trace.go:171","msg":"trace[148876744] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:19001; }","duration":"122.667753ms","start":"2026-10-26T20:01:10.035811Z","end":"2026-10-26T20:01:10.158479Z","steps":["trace[148876744] 'agreement among raft nodes before linearized reading' (duration: 122.387868ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:01:10.55541Z","caller":"traceutil/trace.go:171","msg":"trace[492785461] linearizableReadLoop","detail":"{readStateIndex:19658; appliedIndex:19657; }","duration":"381.286477ms","start":"2026-10-26T20:01:10.174097Z","end":"2026-10-26T20:01:10.555383Z","steps":["trace[492785461] 'read index received' (duration: 302.387139ms)","trace[492785461] 'applied index is now lower than readState.Index' (duration: 78.898198ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:01:10.555589Z","caller":"traceutil/trace.go:171","msg":"trace[1444252489] transaction","detail":"{read_only:false; response_revision:19002; number_of_response:1; }","duration":"388.803079ms","start":"2026-10-26T20:01:10.166712Z","end":"2026-10-26T20:01:10.555515Z","steps":["trace[1444252489] 'process raft request' (duration: 309.748888ms)","trace[1444252489] 'compare' (duration: 78.48145ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T20:01:10.55574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:01:10.166691Z","time spent":"388.936013ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T20:01:10.556706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.574844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:96 size:965600"} {"level":"info","ts":"2026-10-26T20:01:10.55678Z","caller":"traceutil/trace.go:171","msg":"trace[1371100799] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:96; response_revision:19002; }","duration":"378.679757ms","start":"2026-10-26T20:01:10.178083Z","end":"2026-10-26T20:01:10.556763Z","steps":["trace[1371100799] 'agreement among raft nodes before linearized reading' (duration: 377.683927ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:01:10.556822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:01:10.178073Z","time spent":"378.738638ms","remote":"127.0.0.1:35504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":96,"response size":965623,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"warn","ts":"2026-10-26T20:01:10.558247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.138411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:96 size:965600"} {"level":"info","ts":"2026-10-26T20:01:10.55832Z","caller":"traceutil/trace.go:171","msg":"trace[923341146] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:96; response_revision:19002; }","duration":"384.243443ms","start":"2026-10-26T20:01:10.174047Z","end":"2026-10-26T20:01:10.55829Z","steps":["trace[923341146] 'agreement among raft nodes before linearized reading' (duration: 383.179443ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:01:10.558363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:01:10.174022Z","time spent":"384.323794ms","remote":"127.0.0.1:35504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":96,"response size":965623,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"warn","ts":"2026-10-26T20:01:10.832522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.034296ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-26T20:01:10.832689Z","caller":"traceutil/trace.go:171","msg":"trace[676176254] linearizableReadLoop","detail":"{readStateIndex:19660; appliedIndex:19659; }","duration":"139.596547ms","start":"2026-10-26T20:01:10.693067Z","end":"2026-10-26T20:01:10.832664Z","steps":["trace[676176254] 'read index received' (duration: 36.23µs)","trace[676176254] 'applied index is now lower than readState.Index' (duration: 139.558127ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:01:10.832792Z","caller":"traceutil/trace.go:171","msg":"trace[915303938] transaction","detail":"{read_only:false; response_revision:19004; number_of_response:1; }","duration":"182.486377ms","start":"2026-10-26T20:01:10.650289Z","end":"2026-10-26T20:01:10.832776Z","steps":["trace[915303938] 'process raft request' (duration: 41.935751ms)","trace[915303938] 'compare' (duration: 139.788401ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T20:01:10.83365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.574087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-10-26T20:01:10.833707Z","caller":"traceutil/trace.go:171","msg":"trace[1786873805] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:19004; }","duration":"140.674868ms","start":"2026-10-26T20:01:10.693017Z","end":"2026-10-26T20:01:10.833692Z","steps":["trace[1786873805] 'agreement among raft nodes before linearized reading' (duration: 139.955564ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:01:10.962042Z","caller":"traceutil/trace.go:171","msg":"trace[2031052777] transaction","detail":"{read_only:false; response_revision:19006; number_of_response:1; }","duration":"123.827376ms","start":"2026-10-26T20:01:10.838181Z","end":"2026-10-26T20:01:10.962008Z","steps":["trace[2031052777] 'process raft request' (duration: 98.345629ms)","trace[2031052777] 'compare' (duration: 24.927817ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:01:40.202155Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16899} {"level":"info","ts":"2026-10-26T20:01:40.312106Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16899,"took":"105.21279ms","hash":3821098132,"current-db-size-bytes":54550528,"current-db-size":"55 MB","current-db-size-in-use-bytes":32509952,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-26T20:01:40.31217Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3821098132,"revision":16899,"compact-revision":14569} {"level":"info","ts":"2026-10-26T20:01:41.145044Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cf809824ab95ac81","local-member-applied-index":20006,"local-member-snapshot-index":10005,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-26T20:01:41.151452Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20006} {"level":"info","ts":"2026-10-26T20:01:41.151616Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15006} {"level":"info","ts":"2026-10-26T20:06:40.209981Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19330} {"level":"info","ts":"2026-10-26T20:06:40.326191Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19330,"took":"113.480618ms","hash":33818537,"current-db-size-bytes":54550528,"current-db-size":"55 MB","current-db-size-in-use-bytes":30433280,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-26T20:06:40.326339Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":33818537,"revision":19330,"compact-revision":16899} {"level":"warn","ts":"2026-10-26T20:06:46.696607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.841444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-26T20:06:46.696711Z","caller":"traceutil/trace.go:171","msg":"trace[1296374769] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:21685; }","duration":"115.022539ms","start":"2026-10-26T20:06:46.581664Z","end":"2026-10-26T20:06:46.696686Z","steps":["trace[1296374769] 'count revisions from in-memory index tree' (duration: 114.638361ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:06:46.848097Z","caller":"traceutil/trace.go:171","msg":"trace[1423928611] linearizableReadLoop","detail":"{readStateIndex:22427; appliedIndex:22426; }","duration":"144.146654ms","start":"2026-10-26T20:06:46.703922Z","end":"2026-10-26T20:06:46.848068Z","steps":["trace[1423928611] 'read index received' (duration: 143.92188ms)","trace[1423928611] 'applied index is now lower than readState.Index' (duration: 223.684µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:06:46.848147Z","caller":"traceutil/trace.go:171","msg":"trace[346511452] transaction","detail":"{read_only:false; response_revision:21686; number_of_response:1; }","duration":"145.906798ms","start":"2026-10-26T20:06:46.702218Z","end":"2026-10-26T20:06:46.848125Z","steps":["trace[346511452] 'process raft request' (duration: 145.697724ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:06:46.848401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.457371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11795"} {"level":"info","ts":"2026-10-26T20:06:46.848465Z","caller":"traceutil/trace.go:171","msg":"trace[140760393] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:21686; }","duration":"144.574183ms","start":"2026-10-26T20:06:46.703875Z","end":"2026-10-26T20:06:46.848449Z","steps":["trace[140760393] 'agreement among raft nodes before linearized reading' (duration: 144.346998ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:06:47.056282Z","caller":"traceutil/trace.go:171","msg":"trace[862975471] transaction","detail":"{read_only:false; response_revision:21687; number_of_response:1; }","duration":"202.694353ms","start":"2026-10-26T20:06:46.853563Z","end":"2026-10-26T20:06:47.056258Z","steps":["trace[862975471] 'process raft request' (duration: 149.063718ms)","trace[862975471] 'compare' (duration: 53.436441ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:06:47.056578Z","caller":"traceutil/trace.go:171","msg":"trace[622357028] transaction","detail":"{read_only:false; response_revision:21688; number_of_response:1; }","duration":"202.787745ms","start":"2026-10-26T20:06:46.853748Z","end":"2026-10-26T20:06:47.056535Z","steps":["trace[622357028] 'process raft request' (duration: 202.444838ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:07:03.100976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.600275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-26T20:07:03.101069Z","caller":"traceutil/trace.go:171","msg":"trace[2071708054] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21769; }","duration":"164.750358ms","start":"2026-10-26T20:07:02.936297Z","end":"2026-10-26T20:07:03.101047Z","steps":["trace[2071708054] 'range keys from in-memory index tree' (duration: 164.394181ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:07:03.541463Z","caller":"traceutil/trace.go:171","msg":"trace[981764395] transaction","detail":"{read_only:false; response_revision:21770; number_of_response:1; }","duration":"435.575694ms","start":"2026-10-26T20:07:03.105846Z","end":"2026-10-26T20:07:03.541422Z","steps":["trace[981764395] 'process raft request' (duration: 435.340949ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:07:03.541438Z","caller":"traceutil/trace.go:171","msg":"trace[1747336129] linearizableReadLoop","detail":"{readStateIndex:22515; appliedIndex:22514; }","duration":"410.741678ms","start":"2026-10-26T20:07:03.130608Z","end":"2026-10-26T20:07:03.54135Z","steps":["trace[1747336129] 'read index received' (duration: 410.567985ms)","trace[1747336129] 'applied index is now lower than readState.Index' (duration: 172.583µs)"],"step_count":2} {"level":"warn","ts":"2026-10-26T20:07:03.541642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:07:03.105825Z","time spent":"435.731807ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T20:07:03.541666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.037614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-26T20:07:03.541741Z","caller":"traceutil/trace.go:171","msg":"trace[433841408] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21770; }","duration":"411.147336ms","start":"2026-10-26T20:07:03.130572Z","end":"2026-10-26T20:07:03.541719Z","steps":["trace[433841408] 'agreement among raft nodes before linearized reading' (duration: 410.942692ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:07:03.541783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:07:03.130538Z","time spent":"411.236498ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-26T20:07:03.541809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.394813ms","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-10-26T20:07:03.541864Z","caller":"traceutil/trace.go:171","msg":"trace[1969941494] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21770; }","duration":"387.489555ms","start":"2026-10-26T20:07:03.154359Z","end":"2026-10-26T20:07:03.541848Z","steps":["trace[1969941494] 'agreement among raft nodes before linearized reading' (duration: 387.343142ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:07:03.541909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:07:03.154344Z","time spent":"387.556286ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-10-26T20:07:03.783582Z","caller":"traceutil/trace.go:171","msg":"trace[1470742078] linearizableReadLoop","detail":"{readStateIndex:22517; appliedIndex:22515; }","duration":"193.180081ms","start":"2026-10-26T20:07:03.590381Z","end":"2026-10-26T20:07:03.783561Z","steps":["trace[1470742078] 'read index received' (duration: 116.966725ms)","trace[1470742078] 'applied index is now lower than readState.Index' (duration: 76.212296ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:07:03.783864Z","caller":"traceutil/trace.go:171","msg":"trace[1353185844] transaction","detail":"{read_only:false; response_revision:21771; number_of_response:1; }","duration":"238.082509ms","start":"2026-10-26T20:07:03.545751Z","end":"2026-10-26T20:07:03.783833Z","steps":["trace[1353185844] 'process raft request' (duration: 161.596608ms)","trace[1353185844] 'compare' (duration: 76.026643ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:07:03.783874Z","caller":"traceutil/trace.go:171","msg":"trace[1028036359] transaction","detail":"{read_only:false; response_revision:21772; number_of_response:1; }","duration":"236.670652ms","start":"2026-10-26T20:07:03.547172Z","end":"2026-10-26T20:07:03.783843Z","steps":["trace[1028036359] 'process raft request' (duration: 236.314165ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:07:03.783943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.520538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1634"} {"level":"info","ts":"2026-10-26T20:07:03.784005Z","caller":"traceutil/trace.go:171","msg":"trace[1473578358] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:21772; }","duration":"193.64661ms","start":"2026-10-26T20:07:03.590339Z","end":"2026-10-26T20:07:03.783986Z","steps":["trace[1473578358] 'agreement among raft nodes before linearized reading' (duration: 193.459287ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:07:03.784184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.320017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.140\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-10-26T20:07:03.784233Z","caller":"traceutil/trace.go:171","msg":"trace[303554087] range","detail":"{range_begin:/registry/masterleases/162.253.55.140; range_end:; response_count:1; response_revision:21772; }","duration":"122.46779ms","start":"2026-10-26T20:07:03.661748Z","end":"2026-10-26T20:07:03.784216Z","steps":["trace[303554087] 'agreement among raft nodes before linearized reading' (duration: 122.064062ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:07:04.08085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.8475ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-10-26T20:07:04.080936Z","caller":"traceutil/trace.go:171","msg":"trace[1579251395] linearizableReadLoop","detail":"{readStateIndex:22518; appliedIndex:22517; }","duration":"293.995818ms","start":"2026-10-26T20:07:03.786924Z","end":"2026-10-26T20:07:04.08092Z","steps":["trace[1579251395] 'read index received' (duration: 162.064876ms)","trace[1579251395] 'applied index is now lower than readState.Index' (duration: 131.929462ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T20:07:04.08105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.109401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-1afc71b2-e2d8-46bf-aaba-fa2d877cfb3e\" ","response":"range_response_count:1 size:1294"} {"level":"info","ts":"2026-10-26T20:07:04.081096Z","caller":"traceutil/trace.go:171","msg":"trace[458908019] range","detail":"{range_begin:/registry/persistentvolumes/pvc-1afc71b2-e2d8-46bf-aaba-fa2d877cfb3e; range_end:; response_count:1; response_revision:21772; }","duration":"294.182192ms","start":"2026-10-26T20:07:03.786899Z","end":"2026-10-26T20:07:04.081081Z","steps":["trace[458908019] 'agreement among raft nodes before linearized reading' (duration: 294.07013ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:07:04.081179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.060476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/neutron-l3-agent-default-hlgm6.18e22cdfb5f7001a\" ","response":"range_response_count:1 size:949"} {"level":"info","ts":"2026-10-26T20:07:04.081273Z","caller":"traceutil/trace.go:171","msg":"trace[1030302082] range","detail":"{range_begin:/registry/events/openstack/neutron-l3-agent-default-hlgm6.18e22cdfb5f7001a; range_end:; response_count:1; response_revision:21772; }","duration":"185.171829ms","start":"2026-10-26T20:07:03.896056Z","end":"2026-10-26T20:07:04.081228Z","steps":["trace[1030302082] 'agreement among raft nodes before linearized reading' (duration: 184.957834ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:07:04.576402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.074319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-26T20:07:04.576484Z","caller":"traceutil/trace.go:171","msg":"trace[1577898167] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21774; }","duration":"395.199622ms","start":"2026-10-26T20:07:04.181264Z","end":"2026-10-26T20:07:04.576464Z","steps":["trace[1577898167] 'range keys from in-memory index tree' (duration: 395.005448ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:07:04.576525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:07:04.181228Z","time spent":"395.287174ms","remote":"127.0.0.1:35288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-26T20:07:04.576537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.194948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-10-26T20:07:04.57661Z","caller":"traceutil/trace.go:171","msg":"trace[1883886148] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:21774; }","duration":"388.299749ms","start":"2026-10-26T20:07:04.188294Z","end":"2026-10-26T20:07:04.576594Z","steps":["trace[1883886148] 'range keys from in-memory index tree' (duration: 388.109616ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:07:04.576651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:07:04.188269Z","time spent":"388.373901ms","remote":"127.0.0.1:35312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":163,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"warn","ts":"2026-10-26T20:07:04.57679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.564636ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-26T20:07:04.576884Z","caller":"traceutil/trace.go:171","msg":"trace[504739448] transaction","detail":"{read_only:false; response_revision:21775; number_of_response:1; }","duration":"356.604215ms","start":"2026-10-26T20:07:04.220262Z","end":"2026-10-26T20:07:04.576867Z","steps":["trace[504739448] 'process raft request' (duration: 204.891126ms)","trace[504739448] 'compare' (duration: 151.398503ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T20:07:04.576943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:07:04.220218Z","time spent":"356.700457ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T20:07:04.580475Z","caller":"traceutil/trace.go:171","msg":"trace[1190335575] transaction","detail":"{read_only:false; response_revision:21776; number_of_response:1; }","duration":"180.952718ms","start":"2026-10-26T20:07:04.399488Z","end":"2026-10-26T20:07:04.580441Z","steps":["trace[1190335575] 'process raft request' (duration: 180.769915ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:07:04.580494Z","caller":"traceutil/trace.go:171","msg":"trace[2104882107] linearizableReadLoop","detail":"{readStateIndex:22522; appliedIndex:22521; }","duration":"137.494207ms","start":"2026-10-26T20:07:04.442894Z","end":"2026-10-26T20:07:04.580388Z","steps":["trace[2104882107] 'read index received' (duration: 137.358715ms)","trace[2104882107] 'applied index is now lower than readState.Index' (duration: 134.362µs)"],"step_count":2} {"level":"warn","ts":"2026-10-26T20:07:04.580557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.6632ms","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:8"} {"level":"info","ts":"2026-10-26T20:07:04.580594Z","caller":"traceutil/trace.go:171","msg":"trace[268155588] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:21776; }","duration":"137.739872ms","start":"2026-10-26T20:07:04.442843Z","end":"2026-10-26T20:07:04.580583Z","steps":["trace[268155588] 'agreement among raft nodes before linearized reading' (duration: 137.667701ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:07:04.581699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.973337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-26T20:07:04.581796Z","caller":"traceutil/trace.go:171","msg":"trace[1124521037] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21778; }","duration":"125.10933ms","start":"2026-10-26T20:07:04.456663Z","end":"2026-10-26T20:07:04.581772Z","steps":["trace[1124521037] 'agreement among raft nodes before linearized reading' (duration: 124.873836ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:07:04.582127Z","caller":"traceutil/trace.go:171","msg":"trace[2018132349] transaction","detail":"{read_only:false; response_revision:21777; number_of_response:1; }","duration":"123.447469ms","start":"2026-10-26T20:07:04.458667Z","end":"2026-10-26T20:07:04.582115Z","steps":["trace[2018132349] 'process raft request' (duration: 122.711195ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:07:04.582322Z","caller":"traceutil/trace.go:171","msg":"trace[2018853771] transaction","detail":"{read_only:false; response_revision:21778; number_of_response:1; }","duration":"121.448281ms","start":"2026-10-26T20:07:04.460863Z","end":"2026-10-26T20:07:04.582311Z","steps":["trace[2018853771] 'process raft request' (duration: 120.635275ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:10:03.44684Z","caller":"traceutil/trace.go:171","msg":"trace[2053146687] transaction","detail":"{read_only:false; response_revision:23221; number_of_response:1; }","duration":"115.212532ms","start":"2026-10-26T20:10:03.331603Z","end":"2026-10-26T20:10:03.446816Z","steps":["trace[2053146687] 'process raft request' (duration: 37.881514ms)","trace[2053146687] 'compare' (duration: 76.860579ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:10:03.44701Z","caller":"traceutil/trace.go:171","msg":"trace[539672483] transaction","detail":"{read_only:false; response_revision:23222; number_of_response:1; }","duration":"110.901638ms","start":"2026-10-26T20:10:03.336099Z","end":"2026-10-26T20:10:03.447Z","steps":["trace[539672483] 'process raft request' (duration: 110.360368ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:10:03.447115Z","caller":"traceutil/trace.go:171","msg":"trace[365221791] transaction","detail":"{read_only:false; response_revision:23223; number_of_response:1; }","duration":"101.280655ms","start":"2026-10-26T20:10:03.345826Z","end":"2026-10-26T20:10:03.447107Z","steps":["trace[365221791] 'process raft request' (duration: 100.673114ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:10:59.184347Z","caller":"traceutil/trace.go:171","msg":"trace[1069631856] transaction","detail":"{read_only:false; response_revision:24247; number_of_response:1; }","duration":"109.918193ms","start":"2026-10-26T20:10:59.074362Z","end":"2026-10-26T20:10:59.184281Z","steps":["trace[1069631856] 'process raft request' (duration: 109.613417ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:10:59.667423Z","caller":"traceutil/trace.go:171","msg":"trace[816181207] transaction","detail":"{read_only:false; response_revision:24250; number_of_response:1; }","duration":"404.491326ms","start":"2026-10-26T20:10:59.262898Z","end":"2026-10-26T20:10:59.667389Z","steps":["trace[816181207] 'process raft request' (duration: 404.271942ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:10:59.667661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:10:59.262859Z","time spent":"404.66102ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T20:10:59.669968Z","caller":"traceutil/trace.go:171","msg":"trace[2076712290] transaction","detail":"{read_only:false; response_revision:24251; number_of_response:1; }","duration":"182.644064ms","start":"2026-10-26T20:10:59.487295Z","end":"2026-10-26T20:10:59.669939Z","steps":["trace[2076712290] 'process raft request' (duration: 182.508481ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:11:40.224774Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21649} {"level":"info","ts":"2026-10-26T20:11:40.353756Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21649,"took":"124.650644ms","hash":2342951830,"current-db-size-bytes":55545856,"current-db-size":"56 MB","current-db-size-in-use-bytes":42573824,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-10-26T20:11:40.353858Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2342951830,"revision":21649,"compact-revision":19330} {"level":"info","ts":"2026-10-26T20:13:44.353229Z","caller":"traceutil/trace.go:171","msg":"trace[1299942901] linearizableReadLoop","detail":"{readStateIndex:26708; appliedIndex:26707; }","duration":"192.179876ms","start":"2026-10-26T20:13:44.160966Z","end":"2026-10-26T20:13:44.353146Z","steps":["trace[1299942901] 'read index received' (duration: 192.127925ms)","trace[1299942901] 'applied index is now lower than readState.Index' (duration: 50.721µs)"],"step_count":2} {"level":"warn","ts":"2026-10-26T20:13:44.353447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.448211ms","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-10-26T20:13:44.353496Z","caller":"traceutil/trace.go:171","msg":"trace[211648266] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25850; }","duration":"192.536833ms","start":"2026-10-26T20:13:44.160943Z","end":"2026-10-26T20:13:44.35348Z","steps":["trace[211648266] 'agreement among raft nodes before linearized reading' (duration: 192.367849ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:13:44.353565Z","caller":"traceutil/trace.go:171","msg":"trace[1535207881] transaction","detail":"{read_only:false; response_revision:25850; number_of_response:1; }","duration":"227.197516ms","start":"2026-10-26T20:13:44.126332Z","end":"2026-10-26T20:13:44.353529Z","steps":["trace[1535207881] 'process raft request' (duration: 226.670605ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:13:44.384856Z","caller":"traceutil/trace.go:171","msg":"trace[2000595933] transaction","detail":"{read_only:false; response_revision:25851; number_of_response:1; }","duration":"113.972231ms","start":"2026-10-26T20:13:44.270859Z","end":"2026-10-26T20:13:44.384831Z","steps":["trace[2000595933] 'process raft request' (duration: 113.838778ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:13:44.472231Z","caller":"traceutil/trace.go:171","msg":"trace[75924103] transaction","detail":"{read_only:false; response_revision:25852; number_of_response:1; }","duration":"116.676372ms","start":"2026-10-26T20:13:44.355517Z","end":"2026-10-26T20:13:44.472194Z","steps":["trace[75924103] 'process raft request' (duration: 88.169186ms)","trace[75924103] 'compare' (duration: 28.166409ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:13:44.472481Z","caller":"traceutil/trace.go:171","msg":"trace[1298054897] transaction","detail":"{read_only:false; response_revision:25854; number_of_response:1; }","duration":"113.506321ms","start":"2026-10-26T20:13:44.358961Z","end":"2026-10-26T20:13:44.472467Z","steps":["trace[1298054897] 'process raft request' (duration: 113.224017ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:13:44.472577Z","caller":"traceutil/trace.go:171","msg":"trace[795403492] transaction","detail":"{read_only:false; response_revision:25853; number_of_response:1; }","duration":"115.714943ms","start":"2026-10-26T20:13:44.356839Z","end":"2026-10-26T20:13:44.472554Z","steps":["trace[795403492] 'process raft request' (duration: 115.261915ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:14:19.78947Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006998.wal"} {"level":"warn","ts":"2026-10-26T20:14:32.157848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.805496ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-26T20:14:32.158023Z","caller":"traceutil/trace.go:171","msg":"trace[203522761] linearizableReadLoop","detail":"{readStateIndex:27172; appliedIndex:27171; }","duration":"305.112916ms","start":"2026-10-26T20:14:31.852887Z","end":"2026-10-26T20:14:32.158Z","steps":["trace[203522761] 'read index received' (duration: 110.016375ms)","trace[203522761] 'applied index is now lower than readState.Index' (duration: 195.094711ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:14:32.158168Z","caller":"traceutil/trace.go:171","msg":"trace[546328894] transaction","detail":"{read_only:false; response_revision:26301; number_of_response:1; }","duration":"366.315826ms","start":"2026-10-26T20:14:31.791834Z","end":"2026-10-26T20:14:32.15815Z","steps":["trace[546328894] 'process raft request' (duration: 171.046342ms)","trace[546328894] 'compare' (duration: 193.336488ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T20:14:32.158302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:14:31.791807Z","time spent":"366.434229ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T20:14:32.15844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.546515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-10-26T20:14:32.158431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.497874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"} {"level":"info","ts":"2026-10-26T20:14:32.158527Z","caller":"traceutil/trace.go:171","msg":"trace[163015053] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26301; }","duration":"121.690538ms","start":"2026-10-26T20:14:32.036817Z","end":"2026-10-26T20:14:32.158507Z","steps":["trace[163015053] 'agreement among raft nodes before linearized reading' (duration: 121.420593ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:14:32.158573Z","caller":"traceutil/trace.go:171","msg":"trace[1961208153] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:26301; }","duration":"305.688097ms","start":"2026-10-26T20:14:31.852851Z","end":"2026-10-26T20:14:32.158539Z","steps":["trace[1961208153] 'agreement among raft nodes before linearized reading' (duration: 305.31959ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:14:32.158446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.466578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12433"} {"level":"warn","ts":"2026-10-26T20:14:32.158635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:14:31.852839Z","time spent":"305.78498ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":585,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"info","ts":"2026-10-26T20:14:32.158662Z","caller":"traceutil/trace.go:171","msg":"trace[948262520] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26301; }","duration":"265.696062ms","start":"2026-10-26T20:14:31.892932Z","end":"2026-10-26T20:14:32.158628Z","steps":["trace[948262520] 'agreement among raft nodes before linearized reading' (duration: 265.308194ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:14:32.767044Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430393990422500063,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-26T20:14:32.906254Z","caller":"traceutil/trace.go:171","msg":"trace[643584013] transaction","detail":"{read_only:false; response_revision:26304; number_of_response:1; }","duration":"649.636666ms","start":"2026-10-26T20:14:32.256582Z","end":"2026-10-26T20:14:32.906219Z","steps":["trace[643584013] 'process raft request' (duration: 649.394682ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:14:32.906442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:14:32.256556Z","time spent":"649.785069ms","remote":"127.0.0.1:35504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8450,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T20:14:33.101426Z","caller":"traceutil/trace.go:171","msg":"trace[1311406174] transaction","detail":"{read_only:false; response_revision:26305; number_of_response:1; }","duration":"489.390591ms","start":"2026-10-26T20:14:32.611989Z","end":"2026-10-26T20:14:33.101379Z","steps":["trace[1311406174] 'process raft request' (duration: 489.011804ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:14:33.101717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:14:32.611961Z","time spent":"489.594585ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T20:14:33.101737Z","caller":"traceutil/trace.go:171","msg":"trace[545898754] transaction","detail":"{read_only:false; response_revision:26306; number_of_response:1; }","duration":"431.524635ms","start":"2026-10-26T20:14:32.670184Z","end":"2026-10-26T20:14:33.101709Z","steps":["trace[545898754] 'process raft request' (duration: 431.125057ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:14:33.101875Z","caller":"traceutil/trace.go:171","msg":"trace[789353925] transaction","detail":"{read_only:false; response_revision:26307; number_of_response:1; }","duration":"428.881684ms","start":"2026-10-26T20:14:32.672968Z","end":"2026-10-26T20:14:33.10185Z","steps":["trace[789353925] 'process raft request' (duration: 428.64239ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:14:33.101916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:14:32.670166Z","time spent":"431.641896ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T20:14:33.101934Z","caller":"traceutil/trace.go:171","msg":"trace[1636259305] linearizableReadLoop","detail":"{readStateIndex:27180; appliedIndex:27174; }","duration":"835.667295ms","start":"2026-10-26T20:14:32.266241Z","end":"2026-10-26T20:14:33.101908Z","steps":["trace[1636259305] 'read index received' (duration: 639.707157ms)","trace[1636259305] 'applied index is now lower than readState.Index' (duration: 195.958778ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T20:14:33.102025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:14:32.672954Z","time spent":"428.990526ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T20:14:33.102039Z","caller":"traceutil/trace.go:171","msg":"trace[476112139] transaction","detail":"{read_only:false; response_revision:26308; number_of_response:1; }","duration":"406.269071ms","start":"2026-10-26T20:14:32.695731Z","end":"2026-10-26T20:14:33.102Z","steps":["trace[476112139] 'process raft request' (duration: 406.038727ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:14:33.102039Z","caller":"traceutil/trace.go:171","msg":"trace[1005282353] transaction","detail":"{read_only:false; response_revision:26309; number_of_response:1; }","duration":"353.972891ms","start":"2026-10-26T20:14:32.748035Z","end":"2026-10-26T20:14:33.102008Z","steps":["trace[1005282353] 'process raft request' (duration: 353.793078ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:14:33.102232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:14:32.74801Z","time spent":"354.127694ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T20:14:33.10226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:14:32.695714Z","time spent":"406.404463ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T20:14:33.102263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"835.946921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-26T20:14:33.102393Z","caller":"traceutil/trace.go:171","msg":"trace[480224993] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26309; }","duration":"836.200935ms","start":"2026-10-26T20:14:32.266164Z","end":"2026-10-26T20:14:33.102365Z","steps":["trace[480224993] 'agreement among raft nodes before linearized reading' (duration: 835.896809ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:14:33.102461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:14:32.26614Z","time spent":"836.304888ms","remote":"127.0.0.1:35736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-10-26T20:14:33.110675Z","caller":"traceutil/trace.go:171","msg":"trace[1277320470] transaction","detail":"{read_only:false; response_revision:26310; number_of_response:1; }","duration":"197.347026ms","start":"2026-10-26T20:14:32.913297Z","end":"2026-10-26T20:14:33.110644Z","steps":["trace[1277320470] 'process raft request' (duration: 197.06665ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:14:33.110746Z","caller":"traceutil/trace.go:171","msg":"trace[910225579] transaction","detail":"{read_only:false; response_revision:26311; number_of_response:1; }","duration":"196.499809ms","start":"2026-10-26T20:14:32.914225Z","end":"2026-10-26T20:14:33.110724Z","steps":["trace[910225579] 'process raft request' (duration: 196.295535ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:14:33.110842Z","caller":"traceutil/trace.go:171","msg":"trace[650462828] transaction","detail":"{read_only:false; response_revision:26312; number_of_response:1; }","duration":"195.030121ms","start":"2026-10-26T20:14:32.915799Z","end":"2026-10-26T20:14:33.110829Z","steps":["trace[650462828] 'process raft request' (duration: 194.803327ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:14:33.110877Z","caller":"traceutil/trace.go:171","msg":"trace[60728027] transaction","detail":"{read_only:false; response_revision:26313; number_of_response:1; }","duration":"193.233317ms","start":"2026-10-26T20:14:32.917617Z","end":"2026-10-26T20:14:33.11085Z","steps":["trace[60728027] 'process raft request' (duration: 193.057453ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:14:33.111185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.21578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/volumetypes/\" range_end:\"/registry/openstack.k-orc.cloud/volumetypes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-26T20:14:33.111242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.128379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-26T20:14:33.111305Z","caller":"traceutil/trace.go:171","msg":"trace[1888831833] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:26314; }","duration":"291.251261ms","start":"2026-10-26T20:14:32.820038Z","end":"2026-10-26T20:14:33.11129Z","steps":["trace[1888831833] 'agreement among raft nodes before linearized reading' (duration: 291.106308ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:14:33.111312Z","caller":"traceutil/trace.go:171","msg":"trace[918494490] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/volumetypes/; range_end:/registry/openstack.k-orc.cloud/volumetypes0; response_count:0; response_revision:26314; }","duration":"452.396194ms","start":"2026-10-26T20:14:32.658889Z","end":"2026-10-26T20:14:33.111285Z","steps":["trace[918494490] 'agreement among raft nodes before linearized reading' (duration: 452.18803ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:14:33.111338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.631249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-10-26T20:14:33.111363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:14:32.65887Z","time spent":"452.477945ms","remote":"127.0.0.1:56278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/volumetypes/\" range_end:\"/registry/openstack.k-orc.cloud/volumetypes0\" count_only:true "} {"level":"warn","ts":"2026-10-26T20:14:33.111391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.750554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-10-26T20:14:33.111415Z","caller":"traceutil/trace.go:171","msg":"trace[948181683] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26314; }","duration":"486.754331ms","start":"2026-10-26T20:14:32.624641Z","end":"2026-10-26T20:14:33.111396Z","steps":["trace[948181683] 'agreement among raft nodes before linearized reading' (duration: 486.529317ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:14:33.111437Z","caller":"traceutil/trace.go:171","msg":"trace[87252904] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26314; }","duration":"356.840446ms","start":"2026-10-26T20:14:32.75458Z","end":"2026-10-26T20:14:33.111421Z","steps":["trace[87252904] 'agreement among raft nodes before linearized reading' (duration: 356.636032ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:14:33.111468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:14:32.754549Z","time spent":"356.912107ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-26T20:14:33.111473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:14:32.624619Z","time spent":"486.839522ms","remote":"127.0.0.1:35550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-26T20:14:33.111603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"775.732537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/keypairs/\" range_end:\"/registry/openstack.k-orc.cloud/keypairs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-26T20:14:33.111658Z","caller":"traceutil/trace.go:171","msg":"trace[1395949540] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/keypairs/; range_end:/registry/openstack.k-orc.cloud/keypairs0; response_count:0; response_revision:26314; }","duration":"775.845709ms","start":"2026-10-26T20:14:32.335799Z","end":"2026-10-26T20:14:33.111645Z","steps":["trace[1395949540] 'agreement among raft nodes before linearized reading' (duration: 775.726017ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:14:33.111672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.13351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-26T20:14:33.111689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:14:32.335771Z","time spent":"775.908421ms","remote":"127.0.0.1:56492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/keypairs/\" range_end:\"/registry/openstack.k-orc.cloud/keypairs0\" count_only:true "} {"level":"info","ts":"2026-10-26T20:14:33.111705Z","caller":"traceutil/trace.go:171","msg":"trace[757495080] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusterclasses/; range_end:/registry/cluster.x-k8s.io/clusterclasses0; response_count:0; response_revision:26314; }","duration":"689.167241ms","start":"2026-10-26T20:14:32.422524Z","end":"2026-10-26T20:14:33.111691Z","steps":["trace[757495080] 'agreement among raft nodes before linearized reading' (duration: 689.10667ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:14:33.111735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:14:32.422465Z","time spent":"689.263064ms","remote":"127.0.0.1:56070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true "} {"level":"info","ts":"2026-10-26T20:14:48.986729Z","caller":"traceutil/trace.go:171","msg":"trace[1862104917] transaction","detail":"{read_only:false; response_revision:26459; number_of_response:1; }","duration":"155.691208ms","start":"2026-10-26T20:14:48.83101Z","end":"2026-10-26T20:14:48.986701Z","steps":["trace[1862104917] 'process raft request' (duration: 143.463464ms)","trace[1862104917] 'compare' (duration: 11.5007ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:14:48.986792Z","caller":"traceutil/trace.go:171","msg":"trace[1961834647] transaction","detail":"{read_only:false; response_revision:26460; number_of_response:1; }","duration":"155.624848ms","start":"2026-10-26T20:14:48.831141Z","end":"2026-10-26T20:14:48.986765Z","steps":["trace[1961834647] 'process raft request' (duration: 155.333612ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:14:48.986863Z","caller":"traceutil/trace.go:171","msg":"trace[227707072] linearizableReadLoop","detail":"{readStateIndex:27335; appliedIndex:27332; }","duration":"153.895464ms","start":"2026-10-26T20:14:48.83294Z","end":"2026-10-26T20:14:48.986835Z","steps":["trace[227707072] 'read index received' (duration: 38.558938ms)","trace[227707072] 'applied index is now lower than readState.Index' (duration: 115.332956ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T20:14:48.998719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.765421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/persistent-volume-binder\" ","response":"range_response_count:1 size:215"} {"level":"info","ts":"2026-10-26T20:14:48.998781Z","caller":"traceutil/trace.go:171","msg":"trace[463780708] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/persistent-volume-binder; range_end:; response_count:1; response_revision:26460; }","duration":"165.873503ms","start":"2026-10-26T20:14:48.832893Z","end":"2026-10-26T20:14:48.998766Z","steps":["trace[463780708] 'agreement among raft nodes before linearized reading' (duration: 154.056957ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:14:48.999225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.769054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1818"} {"level":"info","ts":"2026-10-26T20:14:48.999278Z","caller":"traceutil/trace.go:171","msg":"trace[995131550] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:26461; }","duration":"138.851125ms","start":"2026-10-26T20:14:48.860413Z","end":"2026-10-26T20:14:48.999264Z","steps":["trace[995131550] 'agreement among raft nodes before linearized reading' (duration: 138.666811ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:14:48.999437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.099901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:112367"} {"level":"info","ts":"2026-10-26T20:14:48.999683Z","caller":"traceutil/trace.go:171","msg":"trace[1362345174] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:26461; }","duration":"161.179272ms","start":"2026-10-26T20:14:48.838301Z","end":"2026-10-26T20:14:48.99948Z","steps":["trace[1362345174] 'agreement among raft nodes before linearized reading' (duration: 160.785425ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:14:49.153688Z","caller":"traceutil/trace.go:171","msg":"trace[2114593028] linearizableReadLoop","detail":"{readStateIndex:27339; appliedIndex:27338; }","duration":"145.677496ms","start":"2026-10-26T20:14:49.007978Z","end":"2026-10-26T20:14:49.153655Z","steps":["trace[2114593028] 'read index received' (duration: 87.189098ms)","trace[2114593028] 'applied index is now lower than readState.Index' (duration: 58.487218ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:14:49.153769Z","caller":"traceutil/trace.go:171","msg":"trace[1986184111] transaction","detail":"{read_only:false; response_revision:26463; number_of_response:1; }","duration":"149.087632ms","start":"2026-10-26T20:14:49.004637Z","end":"2026-10-26T20:14:49.153724Z","steps":["trace[1986184111] 'process raft request' (duration: 90.532722ms)","trace[1986184111] 'compare' (duration: 58.338826ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T20:14:49.153904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.88148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/securitygroups/\" range_end:\"/registry/openstack.k-orc.cloud/securitygroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-26T20:14:49.153967Z","caller":"traceutil/trace.go:171","msg":"trace[1654370654] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/securitygroups/; range_end:/registry/openstack.k-orc.cloud/securitygroups0; response_count:0; response_revision:26463; }","duration":"146.008973ms","start":"2026-10-26T20:14:49.00794Z","end":"2026-10-26T20:14:49.153949Z","steps":["trace[1654370654] 'agreement among raft nodes before linearized reading' (duration: 145.82992ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:14:49.154017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.029193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/openstack/container-infra\" ","response":"range_response_count:1 size:729"} {"level":"info","ts":"2026-10-26T20:14:49.154051Z","caller":"traceutil/trace.go:171","msg":"trace[1593957216] range","detail":"{range_begin:/registry/ingress/openstack/container-infra; range_end:; response_count:1; response_revision:26463; }","duration":"146.100295ms","start":"2026-10-26T20:14:49.00794Z","end":"2026-10-26T20:14:49.154041Z","steps":["trace[1593957216] 'agreement among raft nodes before linearized reading' (duration: 145.900501ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:14:49.163936Z","caller":"traceutil/trace.go:171","msg":"trace[380266831] transaction","detail":"{read_only:false; response_revision:26464; number_of_response:1; }","duration":"155.77084ms","start":"2026-10-26T20:14:49.008138Z","end":"2026-10-26T20:14:49.163909Z","steps":["trace[380266831] 'process raft request' (duration: 155.612397ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:14:49.164246Z","caller":"traceutil/trace.go:171","msg":"trace[1569154135] transaction","detail":"{read_only:false; response_revision:26465; number_of_response:1; }","duration":"142.098527ms","start":"2026-10-26T20:14:49.02213Z","end":"2026-10-26T20:14:49.164228Z","steps":["trace[1569154135] 'process raft request' (duration: 141.714001ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:14:49.164443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.584709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-10-26T20:14:49.164511Z","caller":"traceutil/trace.go:171","msg":"trace[1138801039] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:26465; }","duration":"117.696012ms","start":"2026-10-26T20:14:49.046798Z","end":"2026-10-26T20:14:49.164494Z","steps":["trace[1138801039] 'agreement among raft nodes before linearized reading' (duration: 117.486477ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:14:49.164541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.824997ms","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:4799"} {"level":"warn","ts":"2026-10-26T20:14:49.16456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.293689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3685"} {"level":"info","ts":"2026-10-26T20:14:49.164592Z","caller":"traceutil/trace.go:171","msg":"trace[660810907] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:26465; }","duration":"148.893478ms","start":"2026-10-26T20:14:49.015686Z","end":"2026-10-26T20:14:49.164579Z","steps":["trace[660810907] 'agreement among raft nodes before linearized reading' (duration: 148.773206ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:14:49.164644Z","caller":"traceutil/trace.go:171","msg":"trace[378021302] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:26465; }","duration":"133.437902ms","start":"2026-10-26T20:14:49.031181Z","end":"2026-10-26T20:14:49.164618Z","steps":["trace[378021302] 'agreement among raft nodes before linearized reading' (duration: 133.136126ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:14:49.164897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.660679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3361"} {"level":"info","ts":"2026-10-26T20:14:49.164964Z","caller":"traceutil/trace.go:171","msg":"trace[1560008865] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:26465; }","duration":"154.805561ms","start":"2026-10-26T20:14:49.010138Z","end":"2026-10-26T20:14:49.164944Z","steps":["trace[1560008865] 'agreement among raft nodes before linearized reading' (duration: 153.976545ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:14:49.529944Z","caller":"traceutil/trace.go:171","msg":"trace[1496064151] linearizableReadLoop","detail":"{readStateIndex:27362; appliedIndex:27361; }","duration":"146.091615ms","start":"2026-10-26T20:14:49.383819Z","end":"2026-10-26T20:14:49.529911Z","steps":["trace[1496064151] 'read index received' (duration: 145.706277ms)","trace[1496064151] 'applied index is now lower than readState.Index' (duration: 383.998µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:14:49.530123Z","caller":"traceutil/trace.go:171","msg":"trace[1451137172] transaction","detail":"{read_only:false; response_revision:26486; number_of_response:1; }","duration":"147.36979ms","start":"2026-10-26T20:14:49.382734Z","end":"2026-10-26T20:14:49.530104Z","steps":["trace[1451137172] 'process raft request' (duration: 146.87807ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:14:49.530472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.978528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9750"} {"level":"warn","ts":"2026-10-26T20:14:49.530487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.998355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:994"} {"level":"info","ts":"2026-10-26T20:14:49.530537Z","caller":"traceutil/trace.go:171","msg":"trace[484964326] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:26486; }","duration":"151.04608ms","start":"2026-10-26T20:14:49.37947Z","end":"2026-10-26T20:14:49.530516Z","steps":["trace[484964326] 'agreement among raft nodes before linearized reading' (duration: 150.842906ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:14:49.530553Z","caller":"traceutil/trace.go:171","msg":"trace[256482918] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:26486; }","duration":"143.115828ms","start":"2026-10-26T20:14:49.387417Z","end":"2026-10-26T20:14:49.530532Z","steps":["trace[256482918] 'agreement among raft nodes before linearized reading' (duration: 142.901264ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:15:34.681372Z","caller":"traceutil/trace.go:171","msg":"trace[533958238] linearizableReadLoop","detail":"{readStateIndex:27785; appliedIndex:27784; }","duration":"190.438443ms","start":"2026-10-26T20:15:34.490892Z","end":"2026-10-26T20:15:34.681331Z","steps":["trace[533958238] 'read index received' (duration: 190.239499ms)","trace[533958238] 'applied index is now lower than readState.Index' (duration: 197.594µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:15:34.681403Z","caller":"traceutil/trace.go:171","msg":"trace[1604121526] transaction","detail":"{read_only:false; response_revision:26899; number_of_response:1; }","duration":"241.787065ms","start":"2026-10-26T20:15:34.439571Z","end":"2026-10-26T20:15:34.681359Z","steps":["trace[1604121526] 'process raft request' (duration: 241.580521ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:15:34.681674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.761909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-26T20:15:34.681756Z","caller":"traceutil/trace.go:171","msg":"trace[677066341] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26899; }","duration":"190.8871ms","start":"2026-10-26T20:15:34.49085Z","end":"2026-10-26T20:15:34.681737Z","steps":["trace[677066341] 'agreement among raft nodes before linearized reading' (duration: 190.609225ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:15:34.681787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.589488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-26T20:15:34.68193Z","caller":"traceutil/trace.go:171","msg":"trace[881786715] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:26899; }","duration":"107.841552ms","start":"2026-10-26T20:15:34.574058Z","end":"2026-10-26T20:15:34.6819Z","steps":["trace[881786715] 'agreement among raft nodes before linearized reading' (duration: 107.534657ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:15:34.938551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.373069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12433"} {"level":"info","ts":"2026-10-26T20:15:34.938649Z","caller":"traceutil/trace.go:171","msg":"trace[1113050928] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26900; }","duration":"158.546643ms","start":"2026-10-26T20:15:34.780073Z","end":"2026-10-26T20:15:34.93862Z","steps":["trace[1113050928] 'range keys from in-memory index tree' (duration: 158.076143ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:15:35.545993Z","caller":"traceutil/trace.go:171","msg":"trace[1214162121] transaction","detail":"{read_only:false; response_revision:26901; number_of_response:1; }","duration":"149.311667ms","start":"2026-10-26T20:15:35.396656Z","end":"2026-10-26T20:15:35.545967Z","steps":["trace[1214162121] 'process raft request' (duration: 149.148093ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:15:35.554488Z","caller":"traceutil/trace.go:171","msg":"trace[1186416074] transaction","detail":"{read_only:false; response_revision:26902; number_of_response:1; }","duration":"143.932173ms","start":"2026-10-26T20:15:35.410531Z","end":"2026-10-26T20:15:35.554463Z","steps":["trace[1186416074] 'process raft request' (duration: 143.7509ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:15:35.554712Z","caller":"traceutil/trace.go:171","msg":"trace[1364730571] transaction","detail":"{read_only:false; response_revision:26903; number_of_response:1; }","duration":"143.947004ms","start":"2026-10-26T20:15:35.410754Z","end":"2026-10-26T20:15:35.554701Z","steps":["trace[1364730571] 'process raft request' (duration: 143.611847ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:15:35.554825Z","caller":"traceutil/trace.go:171","msg":"trace[575966493] transaction","detail":"{read_only:false; response_revision:26904; number_of_response:1; }","duration":"144.043635ms","start":"2026-10-26T20:15:35.410769Z","end":"2026-10-26T20:15:35.554812Z","steps":["trace[575966493] 'process raft request' (duration: 143.636977ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:15:35.555258Z","caller":"traceutil/trace.go:171","msg":"trace[2127681076] transaction","detail":"{read_only:false; response_revision:26905; number_of_response:1; }","duration":"144.401651ms","start":"2026-10-26T20:15:35.410845Z","end":"2026-10-26T20:15:35.555247Z","steps":["trace[2127681076] 'process raft request' (duration: 143.809901ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:15:35.55531Z","caller":"traceutil/trace.go:171","msg":"trace[253475039] transaction","detail":"{read_only:false; response_revision:26906; number_of_response:1; }","duration":"141.023256ms","start":"2026-10-26T20:15:35.414265Z","end":"2026-10-26T20:15:35.555288Z","steps":["trace[253475039] 'process raft request' (duration: 140.891105ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:15:35.555303Z","caller":"traceutil/trace.go:171","msg":"trace[1515068233] linearizableReadLoop","detail":"{readStateIndex:27792; appliedIndex:27786; }","duration":"131.755789ms","start":"2026-10-26T20:15:35.423521Z","end":"2026-10-26T20:15:35.555277Z","steps":["trace[1515068233] 'read index received' (duration: 122.428471ms)","trace[1515068233] 'applied index is now lower than readState.Index' (duration: 9.326328ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T20:15:35.555462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.919503ms","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:8"} {"level":"info","ts":"2026-10-26T20:15:35.555504Z","caller":"traceutil/trace.go:171","msg":"trace[1256787726] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26906; }","duration":"132.024134ms","start":"2026-10-26T20:15:35.423467Z","end":"2026-10-26T20:15:35.555491Z","steps":["trace[1256787726] 'agreement among raft nodes before linearized reading' (duration: 131.887172ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:16:40.232026Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24661} {"level":"info","ts":"2026-10-26T20:16:40.39489Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24661,"took":"158.118805ms","hash":2253707661,"current-db-size-bytes":57655296,"current-db-size":"58 MB","current-db-size-in-use-bytes":36347904,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-26T20:16:40.394975Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2253707661,"revision":24661,"compact-revision":21649} {"level":"info","ts":"2026-10-26T20:19:18.484094Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cf809824ab95ac81","local-member-applied-index":30007,"local-member-snapshot-index":20006,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-26T20:19:18.492345Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30007} {"level":"info","ts":"2026-10-26T20:19:18.492481Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25007} {"level":"info","ts":"2026-10-26T20:21:40.243674Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27558} {"level":"info","ts":"2026-10-26T20:21:40.39855Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27558,"took":"149.931388ms","hash":2614747660,"current-db-size-bytes":57655296,"current-db-size":"58 MB","current-db-size-in-use-bytes":34705408,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-10-26T20:21:40.398642Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2614747660,"revision":27558,"compact-revision":24661} {"level":"info","ts":"2026-10-26T20:26:40.252415Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30260} {"level":"info","ts":"2026-10-26T20:26:40.398978Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30260,"took":"141.367185ms","hash":1096735310,"current-db-size-bytes":57655296,"current-db-size":"58 MB","current-db-size-in-use-bytes":30609408,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-26T20:26:40.399058Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1096735310,"revision":30260,"compact-revision":27558} {"level":"info","ts":"2026-10-26T20:31:40.26291Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32508} {"level":"info","ts":"2026-10-26T20:31:40.420615Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32508,"took":"153.182685ms","hash":1943783844,"current-db-size-bytes":57655296,"current-db-size":"58 MB","current-db-size-in-use-bytes":30236672,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-26T20:31:40.420677Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1943783844,"revision":32508,"compact-revision":30260} {"level":"info","ts":"2026-10-26T20:36:40.271577Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34744} {"level":"info","ts":"2026-10-26T20:36:40.426296Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34744,"took":"149.398432ms","hash":3109018100,"current-db-size-bytes":57655296,"current-db-size":"58 MB","current-db-size-in-use-bytes":31719424,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-26T20:36:40.426357Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3109018100,"revision":34744,"compact-revision":32508} {"level":"info","ts":"2026-10-26T20:40:28.699795Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cf809824ab95ac81","local-member-applied-index":40008,"local-member-snapshot-index":30007,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-26T20:40:28.705655Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40008} {"level":"info","ts":"2026-10-26T20:40:28.705951Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35008} {"level":"info","ts":"2026-10-26T20:41:40.28045Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37035} {"level":"info","ts":"2026-10-26T20:41:40.42428Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37035,"took":"139.393141ms","hash":1845844211,"current-db-size-bytes":58507264,"current-db-size":"58 MB","current-db-size-in-use-bytes":33406976,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-26T20:41:40.424348Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1845844211,"revision":37035,"compact-revision":34744} {"level":"info","ts":"2026-10-26T20:46:40.290314Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39319} {"level":"info","ts":"2026-10-26T20:46:40.43499Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39319,"took":"138.747659ms","hash":301115669,"current-db-size-bytes":59772928,"current-db-size":"60 MB","current-db-size-in-use-bytes":31604736,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-26T20:46:40.435062Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":301115669,"revision":39319,"compact-revision":37035}