{"level":"warn","ts":"2026-10-15T14:18:42.250582Z","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-15T14:18:42.25073Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.82: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.82:2380","--initial-cluster=instance=https://162.253.55.82:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.82:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.82: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-15T14:18:42.250804Z","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-15T14:18:42.250815Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.82:2380"]} {"level":"info","ts":"2026-10-15T14:18:42.250839Z","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-15T14:18:42.251743Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.82:2379"]} {"level":"info","ts":"2026-10-15T14:18:42.251829Z","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.82:2380"],"listen-peer-urls":["https://162.253.55.82:2380"],"advertise-client-urls":["https://162.253.55.82:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.82:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.82: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-15T14:18:42.254667Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.54048ms"} {"level":"info","ts":"2026-10-15T14:18:42.260073Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c5298098e2dc0f92","cluster-id":"e15b04acbd0c3f73"} {"level":"info","ts":"2026-10-15T14:18:42.26016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 switched to configuration voters=()"} {"level":"info","ts":"2026-10-15T14:18:42.260178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became follower at term 0"} {"level":"info","ts":"2026-10-15T14:18:42.260196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c5298098e2dc0f92 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-15T14:18:42.260207Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became follower at term 1"} {"level":"info","ts":"2026-10-15T14:18:42.260243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 switched to configuration voters=(14207027893646397330)"} {"level":"warn","ts":"2026-10-15T14:18:42.273704Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-15T14:18:42.276952Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-15T14:18:42.278763Z","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-15T14:18:42.282502Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c5298098e2dc0f92","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-15T14:18:42.282739Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c5298098e2dc0f92","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-15T14:18:42.282796Z","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-15T14:18:42.283258Z","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-15T14:18:42.283308Z","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-15T14:18:42.285279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 switched to configuration voters=(14207027893646397330)"} {"level":"info","ts":"2026-10-15T14:18:42.285613Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e15b04acbd0c3f73","local-member-id":"c5298098e2dc0f92","added-peer-id":"c5298098e2dc0f92","added-peer-peer-urls":["https://162.253.55.82:2380"]} {"level":"info","ts":"2026-10-15T14:18:42.290259Z","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-15T14:18:42.290431Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.82:2380"} {"level":"info","ts":"2026-10-15T14:18:42.290519Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.82:2380"} {"level":"info","ts":"2026-10-15T14:18:42.290731Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c5298098e2dc0f92","initial-advertise-peer-urls":["https://162.253.55.82:2380"],"listen-peer-urls":["https://162.253.55.82:2380"],"advertise-client-urls":["https://162.253.55.82:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.82:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-15T14:18:42.290778Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-15T14:18:42.961516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 is starting a new election at term 1"} {"level":"info","ts":"2026-10-15T14:18:42.961641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-15T14:18:42.961671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 received MsgPreVoteResp from c5298098e2dc0f92 at term 1"} {"level":"info","ts":"2026-10-15T14:18:42.961693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became candidate at term 2"} {"level":"info","ts":"2026-10-15T14:18:42.961704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 received MsgVoteResp from c5298098e2dc0f92 at term 2"} {"level":"info","ts":"2026-10-15T14:18:42.961745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became leader at term 2"} {"level":"info","ts":"2026-10-15T14:18:42.961759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c5298098e2dc0f92 elected leader c5298098e2dc0f92 at term 2"} {"level":"info","ts":"2026-10-15T14:18:42.963273Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T14:18:42.963306Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T14:18:42.963279Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c5298098e2dc0f92","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.82:2379]}","request-path":"/0/members/c5298098e2dc0f92/attributes","cluster-id":"e15b04acbd0c3f73","publish-timeout":"7s"} {"level":"info","ts":"2026-10-15T14:18:42.963475Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T14:18:42.963686Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-15T14:18:42.963728Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-15T14:18:42.964365Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e15b04acbd0c3f73","local-member-id":"c5298098e2dc0f92","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T14:18:42.964468Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T14:18:42.964506Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T14:18:42.965918Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.82:2379"} {"level":"info","ts":"2026-10-15T14:18:42.966487Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-15T14:19:02.372655Z","caller":"traceutil/trace.go:171","msg":"trace[1267536245] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"104.162722ms","start":"2026-10-15T14:19:02.268469Z","end":"2026-10-15T14:19:02.372632Z","steps":["trace[1267536245] 'process raft request' (duration: 104.020829ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:19:32.578715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.036139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-xk2lh\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-10-15T14:19:32.578863Z","caller":"traceutil/trace.go:171","msg":"trace[709903472] range","detail":"{range_begin:/registry/pods/kube-system/cilium-xk2lh; range_end:; response_count:1; response_revision:645; }","duration":"309.224313ms","start":"2026-10-15T14:19:32.269615Z","end":"2026-10-15T14:19:32.578839Z","steps":["trace[709903472] 'range keys from in-memory index tree' (duration: 308.855305ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:19:32.578869Z","caller":"traceutil/trace.go:171","msg":"trace[936270570] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"275.686826ms","start":"2026-10-15T14:19:32.303144Z","end":"2026-10-15T14:19:32.578831Z","steps":["trace[936270570] 'process raft request' (duration: 175.947466ms)","trace[936270570] 'compare' (duration: 99.419513ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:19:32.578912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:19:32.269594Z","time spent":"309.304465ms","remote":"127.0.0.1:38376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-xk2lh\" "} {"level":"warn","ts":"2026-10-15T14:19:33.295872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.343968ms","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-15T14:19:33.296086Z","caller":"traceutil/trace.go:171","msg":"trace[1207328521] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:648; }","duration":"316.600934ms","start":"2026-10-15T14:19:32.979462Z","end":"2026-10-15T14:19:33.296063Z","steps":["trace[1207328521] 'range keys from in-memory index tree' (duration: 316.126153ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:19:33.296162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:19:32.979442Z","time spent":"316.705956ms","remote":"127.0.0.1:38446","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":"info","ts":"2026-10-15T14:19:33.298035Z","caller":"traceutil/trace.go:171","msg":"trace[597200063] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"226.526007ms","start":"2026-10-15T14:19:33.071468Z","end":"2026-10-15T14:19:33.297994Z","steps":["trace[597200063] 'process raft request' (duration: 225.683208ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:19:49.542343Z","caller":"traceutil/trace.go:171","msg":"trace[1993793954] linearizableReadLoop","detail":"{readStateIndex:844; appliedIndex:843; }","duration":"151.699384ms","start":"2026-10-15T14:19:49.390612Z","end":"2026-10-15T14:19:49.542311Z","steps":["trace[1993793954] 'read index received' (duration: 151.570251ms)","trace[1993793954] 'applied index is now lower than readState.Index' (duration: 127.323µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:19:49.542587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.95893ms","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-15T14:19:49.542618Z","caller":"traceutil/trace.go:171","msg":"trace[1311300467] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"157.676043ms","start":"2026-10-15T14:19:49.3847Z","end":"2026-10-15T14:19:49.542376Z","steps":["trace[1311300467] 'process raft request' (duration: 157.424637ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:19:49.542676Z","caller":"traceutil/trace.go:171","msg":"trace[589149326] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:815; }","duration":"152.084313ms","start":"2026-10-15T14:19:49.390572Z","end":"2026-10-15T14:19:49.542657Z","steps":["trace[589149326] 'agreement among raft nodes before linearized reading' (duration: 151.861148ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:19:49.665785Z","caller":"traceutil/trace.go:171","msg":"trace[1726386138] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"248.150928ms","start":"2026-10-15T14:19:49.417604Z","end":"2026-10-15T14:19:49.665755Z","steps":["trace[1726386138] 'process raft request' (duration: 229.571577ms)","trace[1726386138] 'compare' (duration: 18.444778ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:19:49.667609Z","caller":"traceutil/trace.go:171","msg":"trace[207421665] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"119.396646ms","start":"2026-10-15T14:19:49.548152Z","end":"2026-10-15T14:19:49.667549Z","steps":["trace[207421665] 'process raft request' (duration: 119.066999ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:20:19.235565Z","caller":"traceutil/trace.go:171","msg":"trace[496918213] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"225.109735ms","start":"2026-10-15T14:20:19.010425Z","end":"2026-10-15T14:20:19.235535Z","steps":["trace[496918213] 'process raft request' (duration: 192.10963ms)","trace[496918213] 'compare' (duration: 32.881182ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:21:09.94405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.518808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2f82046b-5b48-4688-ab88-611c7b6fff3e\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-10-15T14:21:09.944159Z","caller":"traceutil/trace.go:171","msg":"trace[2074483016] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2f82046b-5b48-4688-ab88-611c7b6fff3e; range_end:; response_count:1; response_revision:1903; }","duration":"159.673762ms","start":"2026-10-15T14:21:09.784459Z","end":"2026-10-15T14:21:09.944133Z","steps":["trace[2074483016] 'range keys from in-memory index tree' (duration: 159.297743ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:21:10.134806Z","caller":"traceutil/trace.go:171","msg":"trace[1593737757] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"182.997151ms","start":"2026-10-15T14:21:09.951785Z","end":"2026-10-15T14:21:10.134783Z","steps":["trace[1593737757] 'process raft request' (duration: 182.841587ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:21:10.550504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.976576ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T14:21:10.550623Z","caller":"traceutil/trace.go:171","msg":"trace[2058878462] linearizableReadLoop","detail":"{readStateIndex:1980; appliedIndex:1979; }","duration":"127.915195ms","start":"2026-10-15T14:21:10.422691Z","end":"2026-10-15T14:21:10.550606Z","steps":["trace[2058878462] 'read index received' (duration: 24.943416ms)","trace[2058878462] 'applied index is now lower than readState.Index' (duration: 102.970269ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:21:10.550796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.17519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-10-15T14:21:10.550763Z","caller":"traceutil/trace.go:171","msg":"trace[864304682] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"249.026991ms","start":"2026-10-15T14:21:10.301674Z","end":"2026-10-15T14:21:10.550701Z","steps":["trace[864304682] 'process raft request' (duration: 145.97052ms)","trace[864304682] 'compare' (duration: 101.846383ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:21:10.550805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.101819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2f82046b-5b48-4688-ab88-611c7b6fff3e\" ","response":"range_response_count:1 size:3746"} {"level":"info","ts":"2026-10-15T14:21:10.55086Z","caller":"traceutil/trace.go:171","msg":"trace[1821144514] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2f82046b-5b48-4688-ab88-611c7b6fff3e; range_end:; response_count:1; response_revision:1906; }","duration":"128.188492ms","start":"2026-10-15T14:21:10.422659Z","end":"2026-10-15T14:21:10.550847Z","steps":["trace[1821144514] 'agreement among raft nodes before linearized reading' (duration: 128.021178ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:21:10.550833Z","caller":"traceutil/trace.go:171","msg":"trace[471205711] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1906; }","duration":"122.239742ms","start":"2026-10-15T14:21:10.428583Z","end":"2026-10-15T14:21:10.550823Z","steps":["trace[471205711] 'agreement among raft nodes before linearized reading' (duration: 122.109449ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:21:26.880188Z","caller":"traceutil/trace.go:171","msg":"trace[1072716437] transaction","detail":"{read_only:false; response_revision:2042; number_of_response:1; }","duration":"225.811936ms","start":"2026-10-15T14:21:26.654341Z","end":"2026-10-15T14:21:26.880153Z","steps":["trace[1072716437] 'process raft request' (duration: 225.537389ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:21:26.88154Z","caller":"traceutil/trace.go:171","msg":"trace[733380946] linearizableReadLoop","detail":"{readStateIndex:2122; appliedIndex:2120; }","duration":"214.353417ms","start":"2026-10-15T14:21:26.667164Z","end":"2026-10-15T14:21:26.881517Z","steps":["trace[733380946] 'read index received' (duration: 212.660027ms)","trace[733380946] 'applied index is now lower than readState.Index' (duration: 1.69236ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:21:26.881579Z","caller":"traceutil/trace.go:171","msg":"trace[497182049] transaction","detail":"{read_only:false; response_revision:2043; number_of_response:1; }","duration":"227.188649ms","start":"2026-10-15T14:21:26.65436Z","end":"2026-10-15T14:21:26.881549Z","steps":["trace[497182049] 'process raft request' (duration: 226.986814ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:21:26.881674Z","caller":"traceutil/trace.go:171","msg":"trace[585417752] transaction","detail":"{read_only:false; response_revision:2044; number_of_response:1; }","duration":"105.568411ms","start":"2026-10-15T14:21:26.776077Z","end":"2026-10-15T14:21:26.881645Z","steps":["trace[585417752] 'process raft request' (duration: 105.403147ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:21:26.881779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.596793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-10-15T14:21:26.88182Z","caller":"traceutil/trace.go:171","msg":"trace[797303396] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2044; }","duration":"214.676564ms","start":"2026-10-15T14:21:26.667131Z","end":"2026-10-15T14:21:26.881807Z","steps":["trace[797303396] 'agreement among raft nodes before linearized reading' (duration: 214.51957ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:21:59.600742Z","caller":"traceutil/trace.go:171","msg":"trace[1109982516] transaction","detail":"{read_only:false; response_revision:2224; number_of_response:1; }","duration":"123.048624ms","start":"2026-10-15T14:21:59.47765Z","end":"2026-10-15T14:21:59.600699Z","steps":["trace[1109982516] 'process raft request' (duration: 43.199656ms)","trace[1109982516] 'compare' (duration: 79.644203ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:22:05.43979Z","caller":"traceutil/trace.go:171","msg":"trace[1729964801] transaction","detail":"{read_only:false; response_revision:2252; number_of_response:1; }","duration":"120.845362ms","start":"2026-10-15T14:22:05.318917Z","end":"2026-10-15T14:22:05.439762Z","steps":["trace[1729964801] 'process raft request' (duration: 120.638767ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:22:05.982639Z","caller":"traceutil/trace.go:171","msg":"trace[1731190526] transaction","detail":"{read_only:false; response_revision:2254; number_of_response:1; }","duration":"356.729539ms","start":"2026-10-15T14:22:05.625883Z","end":"2026-10-15T14:22:05.982612Z","steps":["trace[1731190526] 'process raft request' (duration: 356.579576ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:22:05.982788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:22:05.62584Z","time spent":"356.862663ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T14:22:05.982805Z","caller":"traceutil/trace.go:171","msg":"trace[796520174] linearizableReadLoop","detail":"{readStateIndex:2341; appliedIndex:2341; }","duration":"282.899863ms","start":"2026-10-15T14:22:05.699858Z","end":"2026-10-15T14:22:05.982758Z","steps":["trace[796520174] 'read index received' (duration: 282.884313ms)","trace[796520174] 'applied index is now lower than readState.Index' (duration: 12.58µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:22:05.983087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.232381ms","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-15T14:22:05.983135Z","caller":"traceutil/trace.go:171","msg":"trace[1174738196] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2254; }","duration":"283.326943ms","start":"2026-10-15T14:22:05.699792Z","end":"2026-10-15T14:22:05.983119Z","steps":["trace[1174738196] 'agreement among raft nodes before linearized reading' (duration: 283.080938ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:22:06.271183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.676503ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T14:22:06.271394Z","caller":"traceutil/trace.go:171","msg":"trace[883422233] transaction","detail":"{read_only:false; response_revision:2255; number_of_response:1; }","duration":"508.58589ms","start":"2026-10-15T14:22:05.762783Z","end":"2026-10-15T14:22:06.271369Z","steps":["trace[883422233] 'process raft request' (duration: 343.646401ms)","trace[883422233] 'compare' (duration: 164.570151ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:22:06.271506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:22:05.762751Z","time spent":"508.708924ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T14:22:06.271708Z","caller":"traceutil/trace.go:171","msg":"trace[1125307144] linearizableReadLoop","detail":"{readStateIndex:2343; appliedIndex:2341; }","duration":"254.043595ms","start":"2026-10-15T14:22:06.017634Z","end":"2026-10-15T14:22:06.271678Z","steps":["trace[1125307144] 'read index received' (duration: 88.749687ms)","trace[1125307144] 'applied index is now lower than readState.Index' (duration: 165.291538ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:22:06.271992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.358561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T14:22:06.272059Z","caller":"traceutil/trace.go:171","msg":"trace[1988415624] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:2256; }","duration":"254.473704ms","start":"2026-10-15T14:22:06.01757Z","end":"2026-10-15T14:22:06.272044Z","steps":["trace[1988415624] 'agreement among raft nodes before linearized reading' (duration: 254.263829ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:22:06.272429Z","caller":"traceutil/trace.go:171","msg":"trace[793919590] transaction","detail":"{read_only:false; response_revision:2256; number_of_response:1; }","duration":"283.950487ms","start":"2026-10-15T14:22:05.987805Z","end":"2026-10-15T14:22:06.271756Z","steps":["trace[793919590] 'process raft request' (duration: 283.480876ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:23:14.125042Z","caller":"traceutil/trace.go:171","msg":"trace[261655741] transaction","detail":"{read_only:false; response_revision:2821; number_of_response:1; }","duration":"202.262493ms","start":"2026-10-15T14:23:13.922754Z","end":"2026-10-15T14:23:14.125017Z","steps":["trace[261655741] 'process raft request' (duration: 202.080989ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:23:14.462202Z","caller":"traceutil/trace.go:171","msg":"trace[1505188677] transaction","detail":"{read_only:false; response_revision:2822; number_of_response:1; }","duration":"133.672324ms","start":"2026-10-15T14:23:14.328504Z","end":"2026-10-15T14:23:14.462176Z","steps":["trace[1505188677] 'process raft request' (duration: 133.48612ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:23:14.766911Z","caller":"traceutil/trace.go:171","msg":"trace[336672849] transaction","detail":"{read_only:false; response_revision:2823; number_of_response:1; }","duration":"226.970606ms","start":"2026-10-15T14:23:14.539906Z","end":"2026-10-15T14:23:14.766877Z","steps":["trace[336672849] 'process raft request' (duration: 206.044822ms)","trace[336672849] 'compare' (duration: 20.559895ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:23:14.766903Z","caller":"traceutil/trace.go:171","msg":"trace[507842388] linearizableReadLoop","detail":"{readStateIndex:2933; appliedIndex:2932; }","duration":"155.883359ms","start":"2026-10-15T14:23:14.610987Z","end":"2026-10-15T14:23:14.76687Z","steps":["trace[507842388] 'read index received' (duration: 134.871083ms)","trace[507842388] 'applied index is now lower than readState.Index' (duration: 21.010486ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:23:14.767321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.323859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-15T14:23:14.767456Z","caller":"traceutil/trace.go:171","msg":"trace[953304944] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2823; }","duration":"156.711148ms","start":"2026-10-15T14:23:14.610717Z","end":"2026-10-15T14:23:14.767429Z","steps":["trace[953304944] 'agreement among raft nodes before linearized reading' (duration: 156.196536ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:23:19.899442Z","caller":"traceutil/trace.go:171","msg":"trace[415339609] transaction","detail":"{read_only:false; response_revision:2852; number_of_response:1; }","duration":"154.994337ms","start":"2026-10-15T14:23:19.744416Z","end":"2026-10-15T14:23:19.89941Z","steps":["trace[415339609] 'process raft request' (duration: 154.821293ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:25:55.005053Z","caller":"traceutil/trace.go:171","msg":"trace[27026159] linearizableReadLoop","detail":"{readStateIndex:3952; appliedIndex:3951; }","duration":"139.572239ms","start":"2026-10-15T14:25:54.865453Z","end":"2026-10-15T14:25:55.005025Z","steps":["trace[27026159] 'read index received' (duration: 134.395068ms)","trace[27026159] 'applied index is now lower than readState.Index' (duration: 5.175911ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:25:55.005108Z","caller":"traceutil/trace.go:171","msg":"trace[1094757968] transaction","detail":"{read_only:false; response_revision:3803; number_of_response:1; }","duration":"141.116514ms","start":"2026-10-15T14:25:54.863966Z","end":"2026-10-15T14:25:55.005083Z","steps":["trace[1094757968] 'process raft request' (duration: 135.822621ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:25:55.005229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.730423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/sshkeys.secretgen.k14s.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T14:25:55.005268Z","caller":"traceutil/trace.go:171","msg":"trace[1242185353] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/sshkeys.secretgen.k14s.io; range_end:; response_count:0; response_revision:3803; }","duration":"139.841645ms","start":"2026-10-15T14:25:54.865413Z","end":"2026-10-15T14:25:55.005255Z","steps":["trace[1242185353] 'agreement among raft nodes before linearized reading' (duration: 139.741882ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:25:55.005631Z","caller":"traceutil/trace.go:171","msg":"trace[465654515] transaction","detail":"{read_only:false; response_revision:3804; number_of_response:1; }","duration":"140.05514ms","start":"2026-10-15T14:25:54.865564Z","end":"2026-10-15T14:25:55.005619Z","steps":["trace[465654515] 'process raft request' (duration: 139.885856ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:25:55.005815Z","caller":"traceutil/trace.go:171","msg":"trace[570809384] transaction","detail":"{read_only:false; response_revision:3805; number_of_response:1; }","duration":"110.049457ms","start":"2026-10-15T14:25:54.895756Z","end":"2026-10-15T14:25:55.005805Z","steps":["trace[570809384] 'process raft request' (duration: 109.780351ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:26:27.53148Z","caller":"traceutil/trace.go:171","msg":"trace[1251728755] transaction","detail":"{read_only:false; response_revision:4044; number_of_response:1; }","duration":"125.45366ms","start":"2026-10-15T14:26:27.405995Z","end":"2026-10-15T14:26:27.531449Z","steps":["trace[1251728755] 'process raft request' (duration: 125.238515ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:26:27.733504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.032414ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T14:26:27.733969Z","caller":"traceutil/trace.go:171","msg":"trace[1359292262] transaction","detail":"{read_only:false; response_revision:4045; number_of_response:1; }","duration":"241.107351ms","start":"2026-10-15T14:26:27.492824Z","end":"2026-10-15T14:26:27.733931Z","steps":["trace[1359292262] 'process raft request' (duration: 87.534685ms)","trace[1359292262] 'compare' (duration: 152.827029ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:27:47.557695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.944963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-10-15T14:27:47.558085Z","caller":"traceutil/trace.go:171","msg":"trace[1052881076] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4962; }","duration":"125.130657ms","start":"2026-10-15T14:27:47.432721Z","end":"2026-10-15T14:27:47.557852Z","steps":["trace[1052881076] 'agreement among raft nodes before linearized reading' (duration: 124.81409ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:27:54.257326Z","caller":"traceutil/trace.go:171","msg":"trace[2029135772] transaction","detail":"{read_only:false; response_revision:5111; number_of_response:1; }","duration":"210.046641ms","start":"2026-10-15T14:27:54.04725Z","end":"2026-10-15T14:27:54.257296Z","steps":["trace[2029135772] 'process raft request' (duration: 202.978588ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:27:54.32903Z","caller":"traceutil/trace.go:171","msg":"trace[247193297] linearizableReadLoop","detail":"{readStateIndex:5311; appliedIndex:5309; }","duration":"140.249995ms","start":"2026-10-15T14:27:54.188755Z","end":"2026-10-15T14:27:54.329005Z","steps":["trace[247193297] 'read index received' (duration: 61.482854ms)","trace[247193297] 'applied index is now lower than readState.Index' (duration: 78.766131ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:27:54.329159Z","caller":"traceutil/trace.go:171","msg":"trace[1595469876] transaction","detail":"{read_only:false; response_revision:5112; number_of_response:1; }","duration":"270.429099ms","start":"2026-10-15T14:27:54.058697Z","end":"2026-10-15T14:27:54.329126Z","steps":["trace[1595469876] 'process raft request' (duration: 270.172313ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:27:54.329672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.898751ms","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-15T14:27:54.329746Z","caller":"traceutil/trace.go:171","msg":"trace[1109757533] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5112; }","duration":"140.985812ms","start":"2026-10-15T14:27:54.188723Z","end":"2026-10-15T14:27:54.329709Z","steps":["trace[1109757533] 'agreement among raft nodes before linearized reading' (duration: 140.426389ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:27:54.572654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.811059ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T14:27:54.57291Z","caller":"traceutil/trace.go:171","msg":"trace[184772100] transaction","detail":"{read_only:false; response_revision:5113; number_of_response:1; }","duration":"239.697602ms","start":"2026-10-15T14:27:54.333168Z","end":"2026-10-15T14:27:54.572865Z","steps":["trace[184772100] 'process raft request' (duration: 24.586095ms)","trace[184772100] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/plndr-svcs-lock; req_size:418; } (duration: 214.520894ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:27:54.573018Z","caller":"traceutil/trace.go:171","msg":"trace[38391563] transaction","detail":"{read_only:false; response_revision:5114; number_of_response:1; }","duration":"238.710089ms","start":"2026-10-15T14:27:54.334265Z","end":"2026-10-15T14:27:54.572975Z","steps":["trace[38391563] 'process raft request' (duration: 238.515225ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:27:57.486151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.558818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f1aae987-aed4-445e-a718-eeee374c2b0d\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-10-15T14:27:57.486255Z","caller":"traceutil/trace.go:171","msg":"trace[564347391] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f1aae987-aed4-445e-a718-eeee374c2b0d; range_end:; response_count:1; response_revision:5239; }","duration":"342.715701ms","start":"2026-10-15T14:27:57.143517Z","end":"2026-10-15T14:27:57.486232Z","steps":["trace[564347391] 'range keys from in-memory index tree' (duration: 342.348883ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:27:57.486298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:27:57.143497Z","time spent":"342.791464ms","remote":"127.0.0.1:38376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3624,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f1aae987-aed4-445e-a718-eeee374c2b0d\" "} {"level":"info","ts":"2026-10-15T14:27:59.051695Z","caller":"traceutil/trace.go:171","msg":"trace[1666649827] transaction","detail":"{read_only:false; response_revision:5268; number_of_response:1; }","duration":"100.86863ms","start":"2026-10-15T14:27:58.950781Z","end":"2026-10-15T14:27:59.05165Z","steps":["trace[1666649827] 'process raft request' (duration: 100.727057ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:27:59.271473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.320818ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T14:27:59.27165Z","caller":"traceutil/trace.go:171","msg":"trace[338512665] transaction","detail":"{read_only:false; response_revision:5270; number_of_response:1; }","duration":"215.976176ms","start":"2026-10-15T14:27:59.055642Z","end":"2026-10-15T14:27:59.271618Z","steps":["trace[338512665] 'process raft request' (duration: 88.439674ms)","trace[338512665] 'compare' (duration: 127.224045ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:27:59.271818Z","caller":"traceutil/trace.go:171","msg":"trace[1038018822] linearizableReadLoop","detail":"{readStateIndex:5474; appliedIndex:5472; }","duration":"136.845877ms","start":"2026-10-15T14:27:59.134916Z","end":"2026-10-15T14:27:59.271762Z","steps":["trace[1038018822] 'read index received' (duration: 9.12ms)","trace[1038018822] 'applied index is now lower than readState.Index' (duration: 127.724497ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:27:59.271934Z","caller":"traceutil/trace.go:171","msg":"trace[137517719] transaction","detail":"{read_only:false; response_revision:5271; number_of_response:1; }","duration":"215.738931ms","start":"2026-10-15T14:27:59.056165Z","end":"2026-10-15T14:27:59.271904Z","steps":["trace[137517719] 'process raft request' (duration: 215.407993ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:27:59.272004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.080602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T14:27:59.272039Z","caller":"traceutil/trace.go:171","msg":"trace[2029088389] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:5271; }","duration":"137.151734ms","start":"2026-10-15T14:27:59.134876Z","end":"2026-10-15T14:27:59.272028Z","steps":["trace[2029088389] 'agreement among raft nodes before linearized reading' (duration: 137.082552ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:27:59.272575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.685235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786897"} {"level":"info","ts":"2026-10-15T14:27:59.272627Z","caller":"traceutil/trace.go:171","msg":"trace[1141574416] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5271; }","duration":"120.762487ms","start":"2026-10-15T14:27:59.151851Z","end":"2026-10-15T14:27:59.272614Z","steps":["trace[1141574416] 'agreement among raft nodes before linearized reading' (duration: 120.165794ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:28:12.28442Z","caller":"traceutil/trace.go:171","msg":"trace[2105806669] transaction","detail":"{read_only:false; response_revision:5507; number_of_response:1; }","duration":"231.30638ms","start":"2026-10-15T14:28:12.053075Z","end":"2026-10-15T14:28:12.284382Z","steps":["trace[2105806669] 'process raft request' (duration: 231.097955ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:28:12.286306Z","caller":"traceutil/trace.go:171","msg":"trace[132201731] transaction","detail":"{read_only:false; response_revision:5508; number_of_response:1; }","duration":"221.048481ms","start":"2026-10-15T14:28:12.065232Z","end":"2026-10-15T14:28:12.28628Z","steps":["trace[132201731] 'process raft request' (duration: 220.57877ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:28:20.280542Z","caller":"traceutil/trace.go:171","msg":"trace[515181784] linearizableReadLoop","detail":"{readStateIndex:5861; appliedIndex:5860; }","duration":"111.991859ms","start":"2026-10-15T14:28:20.16853Z","end":"2026-10-15T14:28:20.280522Z","steps":["trace[515181784] 'read index received' (duration: 111.774354ms)","trace[515181784] 'applied index is now lower than readState.Index' (duration: 216.865µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:28:20.280781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.232115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c4f9332b-61f6-47c9-8cb5-2fd82d92f750\" ","response":"range_response_count:1 size:3762"} {"level":"info","ts":"2026-10-15T14:28:20.280914Z","caller":"traceutil/trace.go:171","msg":"trace[2021337174] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c4f9332b-61f6-47c9-8cb5-2fd82d92f750; range_end:; response_count:1; response_revision:5649; }","duration":"112.427429ms","start":"2026-10-15T14:28:20.168461Z","end":"2026-10-15T14:28:20.280889Z","steps":["trace[2021337174] 'agreement among raft nodes before linearized reading' (duration: 112.204364ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:28:20.280931Z","caller":"traceutil/trace.go:171","msg":"trace[50969651] transaction","detail":"{read_only:false; response_revision:5649; number_of_response:1; }","duration":"162.110626ms","start":"2026-10-15T14:28:20.118779Z","end":"2026-10-15T14:28:20.28089Z","steps":["trace[50969651] 'process raft request' (duration: 161.601065ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:28:21.014325Z","caller":"traceutil/trace.go:171","msg":"trace[326642640] transaction","detail":"{read_only:false; response_revision:5651; number_of_response:1; }","duration":"364.376451ms","start":"2026-10-15T14:28:20.649923Z","end":"2026-10-15T14:28:21.0143Z","steps":["trace[326642640] 'process raft request' (duration: 364.204127ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:28:21.014518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:28:20.649887Z","time spent":"364.512035ms","remote":"127.0.0.1:38360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19836,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T14:28:21.0153Z","caller":"traceutil/trace.go:171","msg":"trace[636710891] linearizableReadLoop","detail":"{readStateIndex:5864; appliedIndex:5862; }","duration":"295.67288ms","start":"2026-10-15T14:28:20.719606Z","end":"2026-10-15T14:28:21.015279Z","steps":["trace[636710891] 'read index received' (duration: 294.515613ms)","trace[636710891] 'applied index is now lower than readState.Index' (duration: 1.155907ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:28:21.015339Z","caller":"traceutil/trace.go:171","msg":"trace[955264209] transaction","detail":"{read_only:false; response_revision:5652; number_of_response:1; }","duration":"332.369966ms","start":"2026-10-15T14:28:20.682941Z","end":"2026-10-15T14:28:21.015311Z","steps":["trace[955264209] 'process raft request' (duration: 332.1101ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:28:21.015483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.873274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-10-15T14:28:21.015519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:28:20.682922Z","time spent":"332.495358ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T14:28:21.015529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.304599ms","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-15T14:28:21.015553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.188282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xgp2t\" ","response":"range_response_count:1 size:6526"} {"level":"warn","ts":"2026-10-15T14:28:21.015527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.123899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T14:28:21.015606Z","caller":"traceutil/trace.go:171","msg":"trace[672325165] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xgp2t; range_end:; response_count:1; response_revision:5652; }","duration":"193.280224ms","start":"2026-10-15T14:28:20.822312Z","end":"2026-10-15T14:28:21.015593Z","steps":["trace[672325165] 'agreement among raft nodes before linearized reading' (duration: 193.118441ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:28:21.01558Z","caller":"traceutil/trace.go:171","msg":"trace[1033763355] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5652; }","duration":"285.376671ms","start":"2026-10-15T14:28:20.730189Z","end":"2026-10-15T14:28:21.015566Z","steps":["trace[1033763355] 'agreement among raft nodes before linearized reading' (duration: 285.216707ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:28:21.015618Z","caller":"traceutil/trace.go:171","msg":"trace[1047415797] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:5652; }","duration":"238.274613ms","start":"2026-10-15T14:28:20.777327Z","end":"2026-10-15T14:28:21.015602Z","steps":["trace[1047415797] 'agreement among raft nodes before linearized reading' (duration: 238.116389ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:28:21.015552Z","caller":"traceutil/trace.go:171","msg":"trace[585781116] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5652; }","duration":"295.988028ms","start":"2026-10-15T14:28:20.719545Z","end":"2026-10-15T14:28:21.015533Z","steps":["trace[585781116] 'agreement among raft nodes before linearized reading' (duration: 295.793393ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:28:32.414707Z","caller":"traceutil/trace.go:171","msg":"trace[1263708301] transaction","detail":"{read_only:false; response_revision:5834; number_of_response:1; }","duration":"104.509576ms","start":"2026-10-15T14:28:32.310163Z","end":"2026-10-15T14:28:32.414672Z","steps":["trace[1263708301] 'process raft request' (duration: 104.193078ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:28:32.414972Z","caller":"traceutil/trace.go:171","msg":"trace[851966898] transaction","detail":"{read_only:false; response_revision:5835; number_of_response:1; }","duration":"104.184578ms","start":"2026-10-15T14:28:32.310755Z","end":"2026-10-15T14:28:32.414939Z","steps":["trace[851966898] 'process raft request' (duration: 103.817589ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:28:43.004897Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2980} {"level":"info","ts":"2026-10-15T14:28:43.081459Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2980,"took":"75.07817ms","hash":2789960634,"current-db-size-bytes":57118720,"current-db-size":"57 MB","current-db-size-in-use-bytes":32571392,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-15T14:28:43.082179Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2789960634,"revision":2980,"compact-revision":-1} {"level":"info","ts":"2026-10-15T14:33:43.016799Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5910} {"level":"info","ts":"2026-10-15T14:33:43.125387Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5910,"took":"106.150458ms","hash":1810159794,"current-db-size-bytes":57118720,"current-db-size":"57 MB","current-db-size-in-use-bytes":26779648,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-10-15T14:33:43.125461Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1810159794,"revision":5910,"compact-revision":2980} {"level":"info","ts":"2026-10-15T14:34:33.05018Z","caller":"traceutil/trace.go:171","msg":"trace[949641022] transaction","detail":"{read_only:false; response_revision:8411; number_of_response:1; }","duration":"108.813531ms","start":"2026-10-15T14:34:32.94133Z","end":"2026-10-15T14:34:33.050144Z","steps":["trace[949641022] 'process raft request' (duration: 87.140072ms)","trace[949641022] 'compare' (duration: 21.507695ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:34:41.273025Z","caller":"traceutil/trace.go:171","msg":"trace[755933509] linearizableReadLoop","detail":"{readStateIndex:8892; appliedIndex:8891; }","duration":"173.507559ms","start":"2026-10-15T14:34:41.099498Z","end":"2026-10-15T14:34:41.273005Z","steps":["trace[755933509] 'read index received' (duration: 173.387076ms)","trace[755933509] 'applied index is now lower than readState.Index' (duration: 119.633µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:34:41.273096Z","caller":"traceutil/trace.go:171","msg":"trace[1270224869] transaction","detail":"{read_only:false; response_revision:8582; number_of_response:1; }","duration":"317.651049ms","start":"2026-10-15T14:34:40.955421Z","end":"2026-10-15T14:34:41.273072Z","steps":["trace[1270224869] 'process raft request' (duration: 317.454754ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:34:41.273199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.700743ms","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-15T14:34:41.273228Z","caller":"traceutil/trace.go:171","msg":"trace[691602382] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8582; }","duration":"173.781125ms","start":"2026-10-15T14:34:41.099438Z","end":"2026-10-15T14:34:41.273219Z","steps":["trace[691602382] 'agreement among raft nodes before linearized reading' (duration: 173.672943ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:34:41.273257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:34:40.955404Z","time spent":"317.756562ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T14:34:41.320489Z","caller":"traceutil/trace.go:171","msg":"trace[767455927] transaction","detail":"{read_only:false; response_revision:8583; number_of_response:1; }","duration":"175.527196ms","start":"2026-10-15T14:34:41.144936Z","end":"2026-10-15T14:34:41.320463Z","steps":["trace[767455927] 'process raft request' (duration: 175.419214ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:34:41.320774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.646695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T14:34:41.320858Z","caller":"traceutil/trace.go:171","msg":"trace[1826159642] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8583; }","duration":"200.803509ms","start":"2026-10-15T14:34:41.12004Z","end":"2026-10-15T14:34:41.320844Z","steps":["trace[1826159642] 'agreement among raft nodes before linearized reading' (duration: 200.644685ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:34:41.320926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.93202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xgp2t\" ","response":"range_response_count:1 size:6526"} {"level":"info","ts":"2026-10-15T14:34:41.321015Z","caller":"traceutil/trace.go:171","msg":"trace[816392588] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xgp2t; range_end:; response_count:1; response_revision:8583; }","duration":"131.075204ms","start":"2026-10-15T14:34:41.189919Z","end":"2026-10-15T14:34:41.320994Z","steps":["trace[816392588] 'agreement among raft nodes before linearized reading' (duration: 130.754136ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:34:41.321484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.538749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-10-15T14:34:41.321541Z","caller":"traceutil/trace.go:171","msg":"trace[1990471264] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:8583; }","duration":"106.61687ms","start":"2026-10-15T14:34:41.214906Z","end":"2026-10-15T14:34:41.321523Z","steps":["trace[1990471264] 'agreement among raft nodes before linearized reading' (duration: 106.421226ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:34:41.51859Z","caller":"traceutil/trace.go:171","msg":"trace[308467833] linearizableReadLoop","detail":"{readStateIndex:8895; appliedIndex:8894; }","duration":"186.093914ms","start":"2026-10-15T14:34:41.332463Z","end":"2026-10-15T14:34:41.518556Z","steps":["trace[308467833] 'read index received' (duration: 159.471009ms)","trace[308467833] 'applied index is now lower than readState.Index' (duration: 26.621214ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:34:41.518617Z","caller":"traceutil/trace.go:171","msg":"trace[330242761] transaction","detail":"{read_only:false; response_revision:8585; number_of_response:1; }","duration":"190.022446ms","start":"2026-10-15T14:34:41.328562Z","end":"2026-10-15T14:34:41.518585Z","steps":["trace[330242761] 'process raft request' (duration: 163.399282ms)","trace[330242761] 'compare' (duration: 26.43384ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:34:41.518772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.696629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T14:34:41.518864Z","caller":"traceutil/trace.go:171","msg":"trace[490244189] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8585; }","duration":"195.874213ms","start":"2026-10-15T14:34:41.322976Z","end":"2026-10-15T14:34:41.51885Z","steps":["trace[490244189] 'agreement among raft nodes before linearized reading' (duration: 195.72261ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:34:41.518913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.362855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:224146"} {"level":"info","ts":"2026-10-15T14:34:41.518958Z","caller":"traceutil/trace.go:171","msg":"trace[1769267071] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8585; }","duration":"193.434377ms","start":"2026-10-15T14:34:41.325517Z","end":"2026-10-15T14:34:41.518951Z","steps":["trace[1769267071] 'agreement among raft nodes before linearized reading' (duration: 193.069988ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:34:41.518948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.192782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-10-15T14:34:41.51901Z","caller":"traceutil/trace.go:171","msg":"trace[1297318896] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8585; }","duration":"176.291145ms","start":"2026-10-15T14:34:41.3427Z","end":"2026-10-15T14:34:41.518991Z","steps":["trace[1297318896] 'agreement among raft nodes before linearized reading' (duration: 176.050019ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:34:41.519169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.721339ms","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-15T14:34:41.519223Z","caller":"traceutil/trace.go:171","msg":"trace[1272040522] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8585; }","duration":"169.810392ms","start":"2026-10-15T14:34:41.349397Z","end":"2026-10-15T14:34:41.519207Z","steps":["trace[1272040522] 'agreement among raft nodes before linearized reading' (duration: 169.366991ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:34:52.548724Z","caller":"traceutil/trace.go:171","msg":"trace[1597942410] transaction","detail":"{read_only:false; response_revision:8644; number_of_response:1; }","duration":"110.503762ms","start":"2026-10-15T14:34:52.438197Z","end":"2026-10-15T14:34:52.548701Z","steps":["trace[1597942410] 'process raft request' (duration: 110.340028ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:34:52.930608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.05008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T14:34:52.930699Z","caller":"traceutil/trace.go:171","msg":"trace[2086592254] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:8645; }","duration":"130.203823ms","start":"2026-10-15T14:34:52.800475Z","end":"2026-10-15T14:34:52.930679Z","steps":["trace[2086592254] 'count revisions from in-memory index tree' (duration: 129.935147ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:34:54.078014Z","caller":"traceutil/trace.go:171","msg":"trace[421828353] linearizableReadLoop","detail":"{readStateIndex:8965; appliedIndex:8964; }","duration":"164.011936ms","start":"2026-10-15T14:34:53.913977Z","end":"2026-10-15T14:34:54.077989Z","steps":["trace[421828353] 'read index received' (duration: 163.908303ms)","trace[421828353] 'applied index is now lower than readState.Index' (duration: 102.483µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:34:54.078081Z","caller":"traceutil/trace.go:171","msg":"trace[1420420958] transaction","detail":"{read_only:false; response_revision:8652; number_of_response:1; }","duration":"191.143022ms","start":"2026-10-15T14:34:53.886883Z","end":"2026-10-15T14:34:54.078026Z","steps":["trace[1420420958] 'process raft request' (duration: 190.946127ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:34:54.078225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.224961ms","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-15T14:34:54.078263Z","caller":"traceutil/trace.go:171","msg":"trace[1682065535] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8652; }","duration":"164.319233ms","start":"2026-10-15T14:34:53.913934Z","end":"2026-10-15T14:34:54.078253Z","steps":["trace[1682065535] 'agreement among raft nodes before linearized reading' (duration: 164.150919ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:34:55.016829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.468106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T14:34:55.016899Z","caller":"traceutil/trace.go:171","msg":"trace[1902760803] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:8655; }","duration":"106.602379ms","start":"2026-10-15T14:34:54.910281Z","end":"2026-10-15T14:34:55.016883Z","steps":["trace[1902760803] 'count revisions from in-memory index tree' (duration: 106.366224ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:34:55.01706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.749383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T14:34:55.017084Z","caller":"traceutil/trace.go:171","msg":"trace[1227024007] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:8655; }","duration":"106.813435ms","start":"2026-10-15T14:34:54.910262Z","end":"2026-10-15T14:34:55.017076Z","steps":["trace[1227024007] 'range keys from in-memory index tree' (duration: 106.63058ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:34:55.017343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.579459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T14:34:55.017428Z","caller":"traceutil/trace.go:171","msg":"trace[730012604] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:8655; }","duration":"106.678442ms","start":"2026-10-15T14:34:54.910729Z","end":"2026-10-15T14:34:55.017408Z","steps":["trace[730012604] 'range keys from in-memory index tree' (duration: 106.511867ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:35:16.160518Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002389.wal"} {"level":"info","ts":"2026-10-15T14:35:23.685241Z","caller":"traceutil/trace.go:171","msg":"trace[1121905186] transaction","detail":"{read_only:false; response_revision:8862; number_of_response:1; }","duration":"200.656805ms","start":"2026-10-15T14:35:23.484562Z","end":"2026-10-15T14:35:23.685219Z","steps":["trace[1121905186] 'process raft request' (duration: 200.294457ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:35:25.809378Z","caller":"traceutil/trace.go:171","msg":"trace[2014876978] transaction","detail":"{read_only:false; response_revision:8873; number_of_response:1; }","duration":"120.167608ms","start":"2026-10-15T14:35:25.689178Z","end":"2026-10-15T14:35:25.809346Z","steps":["trace[2014876978] 'process raft request' (duration: 119.743118ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:35:32.834932Z","caller":"traceutil/trace.go:171","msg":"trace[2022909966] transaction","detail":"{read_only:false; response_revision:8914; number_of_response:1; }","duration":"125.477113ms","start":"2026-10-15T14:35:32.709432Z","end":"2026-10-15T14:35:32.834909Z","steps":["trace[2022909966] 'process raft request' (duration: 125.278118ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:35:34.095284Z","caller":"traceutil/trace.go:171","msg":"trace[223946977] transaction","detail":"{read_only:false; response_revision:8921; number_of_response:1; }","duration":"116.962283ms","start":"2026-10-15T14:35:33.978295Z","end":"2026-10-15T14:35:34.095257Z","steps":["trace[223946977] 'process raft request' (duration: 100.690231ms)","trace[223946977] 'compare' (duration: 16.098218ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:35:34.325246Z","caller":"traceutil/trace.go:171","msg":"trace[1491554704] transaction","detail":"{read_only:false; response_revision:8922; number_of_response:1; }","duration":"136.809088ms","start":"2026-10-15T14:35:34.188409Z","end":"2026-10-15T14:35:34.325218Z","steps":["trace[1491554704] 'process raft request' (duration: 37.11981ms)","trace[1491554704] 'compare' (duration: 99.554665ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:35:34.330234Z","caller":"traceutil/trace.go:171","msg":"trace[780741292] transaction","detail":"{read_only:false; response_revision:8923; number_of_response:1; }","duration":"100.530307ms","start":"2026-10-15T14:35:34.229673Z","end":"2026-10-15T14:35:34.330203Z","steps":["trace[780741292] 'process raft request' (duration: 100.360873ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:35:36.942236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.637596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-cwhrj\" ","response":"range_response_count:1 size:4644"} {"level":"info","ts":"2026-10-15T14:35:36.942322Z","caller":"traceutil/trace.go:171","msg":"trace[900295888] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-cwhrj; range_end:; response_count:1; response_revision:8945; }","duration":"108.78527ms","start":"2026-10-15T14:35:36.833517Z","end":"2026-10-15T14:35:36.942302Z","steps":["trace[900295888] 'range keys from in-memory index tree' (duration: 108.457783ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:35:36.942662Z","caller":"traceutil/trace.go:171","msg":"trace[1023631180] transaction","detail":"{read_only:false; response_revision:8946; number_of_response:1; }","duration":"107.644844ms","start":"2026-10-15T14:35:36.835002Z","end":"2026-10-15T14:35:36.942647Z","steps":["trace[1023631180] 'process raft request' (duration: 98.458019ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:35:37.001479Z","caller":"traceutil/trace.go:171","msg":"trace[1174382848] transaction","detail":"{read_only:false; response_revision:8947; number_of_response:1; }","duration":"154.961873ms","start":"2026-10-15T14:35:36.846494Z","end":"2026-10-15T14:35:37.001455Z","steps":["trace[1174382848] 'process raft request' (duration: 154.83738ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:36:41.644759Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c5298098e2dc0f92","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-15T14:36:41.656479Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-15T14:36:41.656636Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-15T14:36:58.703053Z","caller":"traceutil/trace.go:171","msg":"trace[499156098] linearizableReadLoop","detail":"{readStateIndex:10102; appliedIndex:10101; }","duration":"144.959057ms","start":"2026-10-15T14:36:58.558068Z","end":"2026-10-15T14:36:58.703027Z","steps":["trace[499156098] 'read index received' (duration: 58.861623ms)","trace[499156098] 'applied index is now lower than readState.Index' (duration: 86.095874ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:36:58.703092Z","caller":"traceutil/trace.go:171","msg":"trace[642134362] transaction","detail":"{read_only:false; response_revision:9753; number_of_response:1; }","duration":"165.063729ms","start":"2026-10-15T14:36:58.537999Z","end":"2026-10-15T14:36:58.703063Z","steps":["trace[642134362] 'process raft request' (duration: 78.955166ms)","trace[642134362] 'compare' (duration: 85.844057ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:36:58.703316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.234673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-10-15T14:36:58.703318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.73231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xgp2t\" ","response":"range_response_count:1 size:6526"} {"level":"info","ts":"2026-10-15T14:36:58.703351Z","caller":"traceutil/trace.go:171","msg":"trace[1751148201] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9753; }","duration":"145.302895ms","start":"2026-10-15T14:36:58.558037Z","end":"2026-10-15T14:36:58.70334Z","steps":["trace[1751148201] 'agreement among raft nodes before linearized reading' (duration: 145.141491ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:36:58.703363Z","caller":"traceutil/trace.go:171","msg":"trace[1601022668] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xgp2t; range_end:; response_count:1; response_revision:9753; }","duration":"138.807092ms","start":"2026-10-15T14:36:58.564543Z","end":"2026-10-15T14:36:58.70335Z","steps":["trace[1601022668] 'agreement among raft nodes before linearized reading' (duration: 138.635468ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:36:58.973089Z","caller":"traceutil/trace.go:171","msg":"trace[1340298262] linearizableReadLoop","detail":"{readStateIndex:10104; appliedIndex:10102; }","duration":"265.451768ms","start":"2026-10-15T14:36:58.707609Z","end":"2026-10-15T14:36:58.973061Z","steps":["trace[1340298262] 'read index received' (duration: 180.367869ms)","trace[1340298262] 'applied index is now lower than readState.Index' (duration: 85.082869ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:36:58.973118Z","caller":"traceutil/trace.go:171","msg":"trace[2126984453] transaction","detail":"{read_only:false; response_revision:9754; number_of_response:1; }","duration":"267.521397ms","start":"2026-10-15T14:36:58.705554Z","end":"2026-10-15T14:36:58.973075Z","steps":["trace[2126984453] 'process raft request' (duration: 182.409797ms)","trace[2126984453] 'compare' (duration: 84.757701ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:36:58.973134Z","caller":"traceutil/trace.go:171","msg":"trace[148173584] transaction","detail":"{read_only:false; response_revision:9755; number_of_response:1; }","duration":"265.95694ms","start":"2026-10-15T14:36:58.707148Z","end":"2026-10-15T14:36:58.973105Z","steps":["trace[148173584] 'process raft request' (duration: 265.786506ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:36:58.973186Z","caller":"traceutil/trace.go:171","msg":"trace[435523205] transaction","detail":"{read_only:false; response_revision:9756; number_of_response:1; }","duration":"262.365676ms","start":"2026-10-15T14:36:58.710788Z","end":"2026-10-15T14:36:58.973154Z","steps":["trace[435523205] 'process raft request' (duration: 262.208352ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:36:58.973789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.151485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:31 size:291529"} {"level":"warn","ts":"2026-10-15T14:36:58.973712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.526109ms","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-15T14:36:58.973875Z","caller":"traceutil/trace.go:171","msg":"trace[337292115] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:31; response_revision:9756; }","duration":"266.262937ms","start":"2026-10-15T14:36:58.707594Z","end":"2026-10-15T14:36:58.973857Z","steps":["trace[337292115] 'agreement among raft nodes before linearized reading' (duration: 265.617232ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:36:58.973887Z","caller":"traceutil/trace.go:171","msg":"trace[1971052587] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9756; }","duration":"139.749294ms","start":"2026-10-15T14:36:58.834124Z","end":"2026-10-15T14:36:58.973873Z","steps":["trace[1971052587] 'agreement among raft nodes before linearized reading' (duration: 139.424347ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:38:43.024318Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8079} {"level":"info","ts":"2026-10-15T14:38:43.098799Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8079,"took":"72.165846ms","hash":4020020788,"current-db-size-bytes":57118720,"current-db-size":"57 MB","current-db-size-in-use-bytes":28172288,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-15T14:38:43.098924Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4020020788,"revision":8079,"compact-revision":5910} {"level":"info","ts":"2026-10-15T14:42:16.631443Z","caller":"traceutil/trace.go:171","msg":"trace[50639707] linearizableReadLoop","detail":"{readStateIndex:12489; appliedIndex:12488; }","duration":"160.737496ms","start":"2026-10-15T14:42:16.470673Z","end":"2026-10-15T14:42:16.631411Z","steps":["trace[50639707] 'read index received' (duration: 160.592533ms)","trace[50639707] 'applied index is now lower than readState.Index' (duration: 143.503µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:42:16.631626Z","caller":"traceutil/trace.go:171","msg":"trace[94649613] transaction","detail":"{read_only:false; response_revision:12066; number_of_response:1; }","duration":"271.499365ms","start":"2026-10-15T14:42:16.360095Z","end":"2026-10-15T14:42:16.631594Z","steps":["trace[94649613] 'process raft request' (duration: 271.159216ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:42:16.631856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.170776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.82\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-10-15T14:42:16.631945Z","caller":"traceutil/trace.go:171","msg":"trace[1000955047] range","detail":"{range_begin:/registry/masterleases/162.253.55.82; range_end:; response_count:1; response_revision:12066; }","duration":"161.305399ms","start":"2026-10-15T14:42:16.470622Z","end":"2026-10-15T14:42:16.631927Z","steps":["trace[1000955047] 'agreement among raft nodes before linearized reading' (duration: 161.094494ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:42:16.633659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.454399ms","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-15T14:42:16.633787Z","caller":"traceutil/trace.go:171","msg":"trace[134825142] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:12068; }","duration":"160.612454ms","start":"2026-10-15T14:42:16.47315Z","end":"2026-10-15T14:42:16.633763Z","steps":["trace[134825142] 'agreement among raft nodes before linearized reading' (duration: 160.425579ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:42:16.633809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.096779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T14:42:16.634224Z","caller":"traceutil/trace.go:171","msg":"trace[612991185] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:12068; }","duration":"123.392257ms","start":"2026-10-15T14:42:16.510662Z","end":"2026-10-15T14:42:16.634054Z","steps":["trace[612991185] 'agreement among raft nodes before linearized reading' (duration: 123.051579ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:42:38.8428Z","caller":"traceutil/trace.go:171","msg":"trace[1189040249] transaction","detail":"{read_only:false; response_revision:12189; number_of_response:1; }","duration":"106.617581ms","start":"2026-10-15T14:42:38.736159Z","end":"2026-10-15T14:42:38.842777Z","steps":["trace[1189040249] 'process raft request' (duration: 106.451577ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:43:24.667959Z","caller":"traceutil/trace.go:171","msg":"trace[95277482] linearizableReadLoop","detail":"{readStateIndex:12950; appliedIndex:12949; }","duration":"146.429869ms","start":"2026-10-15T14:43:24.521509Z","end":"2026-10-15T14:43:24.667939Z","steps":["trace[95277482] 'read index received' (duration: 146.268735ms)","trace[95277482] 'applied index is now lower than readState.Index' (duration: 160.254µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:43:24.668029Z","caller":"traceutil/trace.go:171","msg":"trace[397492886] transaction","detail":"{read_only:false; response_revision:12512; number_of_response:1; }","duration":"222.293136ms","start":"2026-10-15T14:43:24.445707Z","end":"2026-10-15T14:43:24.668Z","steps":["trace[397492886] 'process raft request' (duration: 222.087991ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:43:24.668159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.632194ms","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-15T14:43:24.668185Z","caller":"traceutil/trace.go:171","msg":"trace[635683946] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:12512; }","duration":"146.707026ms","start":"2026-10-15T14:43:24.521469Z","end":"2026-10-15T14:43:24.668176Z","steps":["trace[635683946] 'agreement among raft nodes before linearized reading' (duration: 146.588403ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:43:25.602388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.532161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T14:43:25.602478Z","caller":"traceutil/trace.go:171","msg":"trace[1825636351] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:12518; }","duration":"112.703005ms","start":"2026-10-15T14:43:25.489754Z","end":"2026-10-15T14:43:25.602457Z","steps":["trace[1825636351] 'count revisions from in-memory index tree' (duration: 112.436319ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:43:30.739321Z","caller":"traceutil/trace.go:171","msg":"trace[879491156] transaction","detail":"{read_only:false; response_revision:12543; number_of_response:1; }","duration":"255.378016ms","start":"2026-10-15T14:43:30.483917Z","end":"2026-10-15T14:43:30.739295Z","steps":["trace[879491156] 'process raft request' (duration: 255.105739ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:43:30.90335Z","caller":"traceutil/trace.go:171","msg":"trace[380738040] transaction","detail":"{read_only:false; response_revision:12545; number_of_response:1; }","duration":"159.490667ms","start":"2026-10-15T14:43:30.74383Z","end":"2026-10-15T14:43:30.903321Z","steps":["trace[380738040] 'process raft request' (duration: 70.806958ms)","trace[380738040] 'compare' (duration: 88.569727ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:43:31.26417Z","caller":"traceutil/trace.go:171","msg":"trace[876866940] transaction","detail":"{read_only:false; response_revision:12546; number_of_response:1; }","duration":"189.633847ms","start":"2026-10-15T14:43:31.074507Z","end":"2026-10-15T14:43:31.264141Z","steps":["trace[876866940] 'process raft request' (duration: 189.470513ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:43:31.279289Z","caller":"traceutil/trace.go:171","msg":"trace[1931866481] transaction","detail":"{read_only:false; response_revision:12547; number_of_response:1; }","duration":"121.135634ms","start":"2026-10-15T14:43:31.158112Z","end":"2026-10-15T14:43:31.279248Z","steps":["trace[1931866481] 'process raft request' (duration: 120.927189ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:43:43.031377Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10472} {"level":"info","ts":"2026-10-15T14:43:43.120402Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10472,"took":"86.759664ms","hash":540498055,"current-db-size-bytes":57118720,"current-db-size":"57 MB","current-db-size-in-use-bytes":26124288,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-15T14:43:43.120473Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":540498055,"revision":10472,"compact-revision":8079} {"level":"info","ts":"2026-10-15T14:48:43.038558Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12635} {"level":"info","ts":"2026-10-15T14:48:43.123179Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12635,"took":"82.217059ms","hash":134690988,"current-db-size-bytes":57118720,"current-db-size":"57 MB","current-db-size-in-use-bytes":27344896,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-10-15T14:48:43.12325Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":134690988,"revision":12635,"compact-revision":10472} {"level":"info","ts":"2026-10-15T14:49:15.230247Z","caller":"traceutil/trace.go:171","msg":"trace[1492328530] transaction","detail":"{read_only:false; response_revision:14837; number_of_response:1; }","duration":"101.65625ms","start":"2026-10-15T14:49:15.128574Z","end":"2026-10-15T14:49:15.23023Z","steps":["trace[1492328530] 'process raft request' (duration: 101.524586ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:49:15.371911Z","caller":"traceutil/trace.go:171","msg":"trace[754850525] linearizableReadLoop","detail":"{readStateIndex:15361; appliedIndex:15359; }","duration":"157.209396ms","start":"2026-10-15T14:49:15.214665Z","end":"2026-10-15T14:49:15.371874Z","steps":["trace[754850525] 'read index received' (duration: 15.464816ms)","trace[754850525] 'applied index is now lower than readState.Index' (duration: 141.74309ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:49:15.372028Z","caller":"traceutil/trace.go:171","msg":"trace[1422548144] transaction","detail":"{read_only:false; response_revision:14838; number_of_response:1; }","duration":"189.88891ms","start":"2026-10-15T14:49:15.182093Z","end":"2026-10-15T14:49:15.371982Z","steps":["trace[1422548144] 'process raft request' (duration: 152.401282ms)","trace[1422548144] 'compare' (duration: 37.199231ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:49:15.372208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.505643ms","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":"warn","ts":"2026-10-15T14:49:15.372301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.5223ms","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-15T14:49:15.372302Z","caller":"traceutil/trace.go:171","msg":"trace[653563711] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14838; }","duration":"157.655406ms","start":"2026-10-15T14:49:15.214624Z","end":"2026-10-15T14:49:15.372279Z","steps":["trace[653563711] 'agreement among raft nodes before linearized reading' (duration: 157.37286ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:49:15.372306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.480629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T14:49:15.372339Z","caller":"traceutil/trace.go:171","msg":"trace[930934520] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14838; }","duration":"156.589911ms","start":"2026-10-15T14:49:15.215735Z","end":"2026-10-15T14:49:15.372325Z","steps":["trace[930934520] 'agreement among raft nodes before linearized reading' (duration: 156.52816ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:49:15.372347Z","caller":"traceutil/trace.go:171","msg":"trace[1298882781] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14838; }","duration":"132.591173ms","start":"2026-10-15T14:49:15.239744Z","end":"2026-10-15T14:49:15.372335Z","steps":["trace[1298882781] 'agreement among raft nodes before linearized reading' (duration: 132.49705ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:49:15.372221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.738125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-15T14:49:15.372504Z","caller":"traceutil/trace.go:171","msg":"trace[1431253930] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14838; }","duration":"157.009472ms","start":"2026-10-15T14:49:15.215453Z","end":"2026-10-15T14:49:15.372462Z","steps":["trace[1431253930] 'agreement among raft nodes before linearized reading' (duration: 156.618662ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:49:16.135773Z","caller":"traceutil/trace.go:171","msg":"trace[626949548] transaction","detail":"{read_only:false; response_revision:14843; number_of_response:1; }","duration":"101.849164ms","start":"2026-10-15T14:49:16.033903Z","end":"2026-10-15T14:49:16.135752Z","steps":["trace[626949548] 'process raft request' (duration: 101.478075ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:49:39.720055Z","caller":"traceutil/trace.go:171","msg":"trace[1655665952] linearizableReadLoop","detail":"{readStateIndex:15695; appliedIndex:15694; }","duration":"197.45787ms","start":"2026-10-15T14:49:39.52257Z","end":"2026-10-15T14:49:39.720028Z","steps":["trace[1655665952] 'read index received' (duration: 197.173214ms)","trace[1655665952] 'applied index is now lower than readState.Index' (duration: 283.286µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:49:39.720172Z","caller":"traceutil/trace.go:171","msg":"trace[996647754] transaction","detail":"{read_only:false; response_revision:15158; number_of_response:1; }","duration":"260.3263ms","start":"2026-10-15T14:49:39.459804Z","end":"2026-10-15T14:49:39.720131Z","steps":["trace[996647754] 'process raft request' (duration: 260.013382ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:49:39.720368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.881912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-15T14:49:39.720424Z","caller":"traceutil/trace.go:171","msg":"trace[1733033682] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15158; }","duration":"192.969433ms","start":"2026-10-15T14:49:39.527438Z","end":"2026-10-15T14:49:39.720408Z","steps":["trace[1733033682] 'agreement among raft nodes before linearized reading' (duration: 192.749968ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:49:39.720581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.57274ms","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-15T14:49:39.720794Z","caller":"traceutil/trace.go:171","msg":"trace[906523755] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15158; }","duration":"188.783264ms","start":"2026-10-15T14:49:39.531907Z","end":"2026-10-15T14:49:39.720691Z","steps":["trace[906523755] 'agreement among raft nodes before linearized reading' (duration: 188.393065ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:49:39.720823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.234879ms","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-15T14:49:39.721023Z","caller":"traceutil/trace.go:171","msg":"trace[1683115123] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15158; }","duration":"198.476515ms","start":"2026-10-15T14:49:39.522524Z","end":"2026-10-15T14:49:39.721001Z","steps":["trace[1683115123] 'agreement among raft nodes before linearized reading' (duration: 197.618624ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:51:06.737117Z","caller":"traceutil/trace.go:171","msg":"trace[828606121] transaction","detail":"{read_only:false; response_revision:15973; number_of_response:1; }","duration":"186.985653ms","start":"2026-10-15T14:51:06.550105Z","end":"2026-10-15T14:51:06.737091Z","steps":["trace[828606121] 'process raft request' (duration: 186.393258ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:51:07.025787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.407979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"} {"level":"info","ts":"2026-10-15T14:51:07.025904Z","caller":"traceutil/trace.go:171","msg":"trace[1278967718] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15973; }","duration":"100.570012ms","start":"2026-10-15T14:51:06.925311Z","end":"2026-10-15T14:51:07.025881Z","steps":["trace[1278967718] 'range keys from in-memory index tree' (duration: 99.925176ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:51:07.209241Z","caller":"traceutil/trace.go:171","msg":"trace[1458457733] transaction","detail":"{read_only:false; response_revision:15974; number_of_response:1; }","duration":"130.245757ms","start":"2026-10-15T14:51:07.078968Z","end":"2026-10-15T14:51:07.209214Z","steps":["trace[1458457733] 'process raft request' (duration: 130.101294ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:51:07.429889Z","caller":"traceutil/trace.go:171","msg":"trace[30617529] linearizableReadLoop","detail":"{readStateIndex:16536; appliedIndex:16535; }","duration":"307.95744ms","start":"2026-10-15T14:51:07.121901Z","end":"2026-10-15T14:51:07.429858Z","steps":["trace[30617529] 'read index received' (duration: 87.372145ms)","trace[30617529] 'applied index is now lower than readState.Index' (duration: 220.584075ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:51:07.430231Z","caller":"traceutil/trace.go:171","msg":"trace[291586478] transaction","detail":"{read_only:false; response_revision:15975; number_of_response:1; }","duration":"346.262719ms","start":"2026-10-15T14:51:07.083952Z","end":"2026-10-15T14:51:07.430214Z","steps":["trace[291586478] 'process raft request' (duration: 308.563535ms)","trace[291586478] 'compare' (duration: 36.74869ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:51:07.430368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:51:07.08394Z","time spent":"346.330561ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T14:51:07.430683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.77148ms","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-15T14:51:07.430757Z","caller":"traceutil/trace.go:171","msg":"trace[1879508763] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15975; }","duration":"308.865183ms","start":"2026-10-15T14:51:07.121878Z","end":"2026-10-15T14:51:07.430743Z","steps":["trace[1879508763] 'agreement among raft nodes before linearized reading' (duration: 308.688109ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:51:07.430754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.741346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T14:51:07.430794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:51:07.121867Z","time spent":"308.917444ms","remote":"127.0.0.1:38446","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-15T14:51:07.430826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.019484ms","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-15T14:51:07.430848Z","caller":"traceutil/trace.go:171","msg":"trace[387096111] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15975; }","duration":"188.88107ms","start":"2026-10-15T14:51:07.24194Z","end":"2026-10-15T14:51:07.430821Z","steps":["trace[387096111] 'agreement among raft nodes before linearized reading' (duration: 188.711996ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:51:07.430882Z","caller":"traceutil/trace.go:171","msg":"trace[1950813600] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15975; }","duration":"302.097515ms","start":"2026-10-15T14:51:07.128769Z","end":"2026-10-15T14:51:07.430867Z","steps":["trace[1950813600] 'agreement among raft nodes before linearized reading' (duration: 301.87609ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:51:07.430919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:51:07.128759Z","time spent":"302.147176ms","remote":"127.0.0.1:38446","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":"warn","ts":"2026-10-15T14:51:07.667406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.54961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"} {"level":"info","ts":"2026-10-15T14:51:07.667582Z","caller":"traceutil/trace.go:171","msg":"trace[593650072] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15977; }","duration":"110.749614ms","start":"2026-10-15T14:51:07.556807Z","end":"2026-10-15T14:51:07.667556Z","steps":["trace[593650072] 'range keys from in-memory index tree' (duration: 110.400096ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:51:07.667743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.418991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T14:51:07.667784Z","caller":"traceutil/trace.go:171","msg":"trace[558945272] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15977; }","duration":"111.495182ms","start":"2026-10-15T14:51:07.556277Z","end":"2026-10-15T14:51:07.667772Z","steps":["trace[558945272] 'range keys from in-memory index tree' (duration: 111.343888ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:51:07.667438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.307844ms","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-15T14:51:07.66816Z","caller":"traceutil/trace.go:171","msg":"trace[1977792587] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15977; }","duration":"109.048333ms","start":"2026-10-15T14:51:07.559091Z","end":"2026-10-15T14:51:07.668139Z","steps":["trace[1977792587] 'range keys from in-memory index tree' (duration: 108.17332ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:51:07.66807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.436191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T14:51:07.668227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.515913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-metadata\" ","response":"range_response_count:1 size:680"} {"level":"info","ts":"2026-10-15T14:51:07.668294Z","caller":"traceutil/trace.go:171","msg":"trace[823724749] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:0; response_revision:15977; }","duration":"111.719158ms","start":"2026-10-15T14:51:07.556559Z","end":"2026-10-15T14:51:07.668278Z","steps":["trace[823724749] 'range keys from in-memory index tree' (duration: 111.354609ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:51:07.668312Z","caller":"traceutil/trace.go:171","msg":"trace[1830645698] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-metadata; range_end:; response_count:1; response_revision:15977; }","duration":"111.647626ms","start":"2026-10-15T14:51:07.556645Z","end":"2026-10-15T14:51:07.668292Z","steps":["trace[1830645698] 'range keys from in-memory index tree' (duration: 111.338609ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:53:43.046556Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14659} {"level":"info","ts":"2026-10-15T14:53:43.128779Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14659,"took":"79.648833ms","hash":927328317,"current-db-size-bytes":57118720,"current-db-size":"57 MB","current-db-size-in-use-bytes":32018432,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-15T14:53:43.128855Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":927328317,"revision":14659,"compact-revision":12635} {"level":"info","ts":"2026-10-15T14:56:27.275797Z","caller":"traceutil/trace.go:171","msg":"trace[310670036] linearizableReadLoop","detail":"{readStateIndex:18980; appliedIndex:18979; }","duration":"209.845147ms","start":"2026-10-15T14:56:27.065916Z","end":"2026-10-15T14:56:27.275761Z","steps":["trace[310670036] 'read index received' (duration: 209.504278ms)","trace[310670036] 'applied index is now lower than readState.Index' (duration: 339.029µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:56:27.276144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.194066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-15T14:56:27.276252Z","caller":"traceutil/trace.go:171","msg":"trace[1810225891] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18339; }","duration":"210.34216ms","start":"2026-10-15T14:56:27.065893Z","end":"2026-10-15T14:56:27.276235Z","steps":["trace[1810225891] 'agreement among raft nodes before linearized reading' (duration: 210.054723ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:56:27.276635Z","caller":"traceutil/trace.go:171","msg":"trace[1248609475] transaction","detail":"{read_only:false; response_revision:18339; number_of_response:1; }","duration":"215.348188ms","start":"2026-10-15T14:56:27.060548Z","end":"2026-10-15T14:56:27.275896Z","steps":["trace[1248609475] 'process raft request' (duration: 214.956108ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:56:27.287204Z","caller":"traceutil/trace.go:171","msg":"trace[730304613] transaction","detail":"{read_only:false; response_revision:18340; number_of_response:1; }","duration":"166.294725ms","start":"2026-10-15T14:56:27.120892Z","end":"2026-10-15T14:56:27.287187Z","steps":["trace[730304613] 'process raft request' (duration: 166.109461ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:56:27.287508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.045019ms","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-15T14:56:27.287549Z","caller":"traceutil/trace.go:171","msg":"trace[2104940696] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18341; }","duration":"102.147723ms","start":"2026-10-15T14:56:27.185391Z","end":"2026-10-15T14:56:27.287539Z","steps":["trace[2104940696] 'agreement among raft nodes before linearized reading' (duration: 101.997329ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:56:28.019917Z","caller":"traceutil/trace.go:171","msg":"trace[1753562556] transaction","detail":"{read_only:false; response_revision:18344; number_of_response:1; }","duration":"102.774218ms","start":"2026-10-15T14:56:27.917105Z","end":"2026-10-15T14:56:28.01988Z","steps":["trace[1753562556] 'process raft request' (duration: 101.819163ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:57:16.665875Z","caller":"traceutil/trace.go:171","msg":"trace[1182771144] linearizableReadLoop","detail":"{readStateIndex:19322; appliedIndex:19321; }","duration":"280.664012ms","start":"2026-10-15T14:57:16.385176Z","end":"2026-10-15T14:57:16.66584Z","steps":["trace[1182771144] 'read index received' (duration: 205.882305ms)","trace[1182771144] 'applied index is now lower than readState.Index' (duration: 74.780237ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:57:16.666214Z","caller":"traceutil/trace.go:171","msg":"trace[466847841] transaction","detail":"{read_only:false; response_revision:18672; number_of_response:1; }","duration":"285.684311ms","start":"2026-10-15T14:57:16.380505Z","end":"2026-10-15T14:57:16.666189Z","steps":["trace[466847841] 'process raft request' (duration: 210.646348ms)","trace[466847841] 'compare' (duration: 74.477148ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:57:16.666501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.312468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/openstack/\" range_end:\"/registry/resourcequotas/openstack0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T14:57:16.666585Z","caller":"traceutil/trace.go:171","msg":"trace[1664284092] range","detail":"{range_begin:/registry/resourcequotas/openstack/; range_end:/registry/resourcequotas/openstack0; response_count:0; response_revision:18672; }","duration":"281.425851ms","start":"2026-10-15T14:57:16.385118Z","end":"2026-10-15T14:57:16.666544Z","steps":["trace[1664284092] 'agreement among raft nodes before linearized reading' (duration: 281.319228ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:57:16.666979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.456509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-15T14:57:16.667034Z","caller":"traceutil/trace.go:171","msg":"trace[128372292] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18672; }","duration":"277.539591ms","start":"2026-10-15T14:57:16.389481Z","end":"2026-10-15T14:57:16.667021Z","steps":["trace[128372292] 'agreement among raft nodes before linearized reading' (duration: 277.372607ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:57:16.667613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.412248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.82\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-10-15T14:57:16.667707Z","caller":"traceutil/trace.go:171","msg":"trace[783406356] range","detail":"{range_begin:/registry/masterleases/162.253.55.82; range_end:; response_count:1; response_revision:18672; }","duration":"147.555411ms","start":"2026-10-15T14:57:16.520134Z","end":"2026-10-15T14:57:16.66769Z","steps":["trace[783406356] 'agreement among raft nodes before linearized reading' (duration: 147.367917ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:57:17.037537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.663008ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:42"} {"level":"info","ts":"2026-10-15T14:57:17.037791Z","caller":"traceutil/trace.go:171","msg":"trace[315371977] linearizableReadLoop","detail":"{readStateIndex:19326; appliedIndex:19323; }","duration":"342.044243ms","start":"2026-10-15T14:57:16.695733Z","end":"2026-10-15T14:57:17.037777Z","steps":["trace[315371977] 'read index received' (duration: 72.227861ms)","trace[315371977] 'applied index is now lower than readState.Index' (duration: 269.815722ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:57:17.037804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:57:16.669194Z","time spent":"368.598278ms","remote":"127.0.0.1:38212","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-10-15T14:57:17.037939Z","caller":"traceutil/trace.go:171","msg":"trace[1139913895] transaction","detail":"{read_only:false; response_revision:18674; number_of_response:1; }","duration":"365.9822ms","start":"2026-10-15T14:57:16.671949Z","end":"2026-10-15T14:57:17.037931Z","steps":["trace[1139913895] 'process raft request' (duration: 365.662132ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:57:17.038012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:57:16.671933Z","time spent":"366.030711ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T14:57:17.0381Z","caller":"traceutil/trace.go:171","msg":"trace[709044022] transaction","detail":"{read_only:false; response_revision:18675; number_of_response:1; }","duration":"347.277058ms","start":"2026-10-15T14:57:16.690804Z","end":"2026-10-15T14:57:17.038081Z","steps":["trace[709044022] 'process raft request' (duration: 346.943659ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:57:17.038189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:57:16.690779Z","time spent":"347.365401ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T14:57:17.038807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.041259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat\" ","response":"range_response_count:1 size:1647"} {"level":"info","ts":"2026-10-15T14:57:17.038909Z","caller":"traceutil/trace.go:171","msg":"trace[1397193617] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat; range_end:; response_count:1; response_revision:18675; }","duration":"343.151782ms","start":"2026-10-15T14:57:16.695728Z","end":"2026-10-15T14:57:17.03888Z","steps":["trace[1397193617] 'agreement among raft nodes before linearized reading' (duration: 342.31212ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:57:17.038968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:57:16.695661Z","time spent":"343.293116ms","remote":"127.0.0.1:53764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":1671,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat\" "} {"level":"info","ts":"2026-10-15T14:57:17.055728Z","caller":"traceutil/trace.go:171","msg":"trace[868086613] transaction","detail":"{read_only:false; response_revision:18676; number_of_response:1; }","duration":"175.611535ms","start":"2026-10-15T14:57:16.880082Z","end":"2026-10-15T14:57:17.055694Z","steps":["trace[868086613] 'process raft request' (duration: 175.42968ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:57:17.055809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.739687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat\" ","response":"range_response_count:1 size:1647"} {"level":"info","ts":"2026-10-15T14:57:17.055874Z","caller":"traceutil/trace.go:171","msg":"trace[702106854] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat; range_end:; response_count:1; response_revision:18676; }","duration":"357.84047ms","start":"2026-10-15T14:57:16.698015Z","end":"2026-10-15T14:57:17.055856Z","steps":["trace[702106854] 'agreement among raft nodes before linearized reading' (duration: 357.616294ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:57:17.055912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:57:16.698002Z","time spent":"357.899481ms","remote":"127.0.0.1:53764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":1671,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat\" "} {"level":"warn","ts":"2026-10-15T14:57:17.055908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.180889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-c9d44\" ","response":"range_response_count:1 size:20758"} {"level":"info","ts":"2026-10-15T14:57:17.055964Z","caller":"traceutil/trace.go:171","msg":"trace[1670590585] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-c9d44; range_end:; response_count:1; response_revision:18676; }","duration":"150.290192ms","start":"2026-10-15T14:57:16.905657Z","end":"2026-10-15T14:57:17.055947Z","steps":["trace[1670590585] 'agreement among raft nodes before linearized reading' (duration: 150.118378ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:57:17.6Z","caller":"traceutil/trace.go:171","msg":"trace[1766721372] linearizableReadLoop","detail":"{readStateIndex:19330; appliedIndex:19329; }","duration":"474.965138ms","start":"2026-10-15T14:57:17.125009Z","end":"2026-10-15T14:57:17.599974Z","steps":["trace[1766721372] 'read index received' (duration: 474.804494ms)","trace[1766721372] 'applied index is now lower than readState.Index' (duration: 159.624µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:57:17.600048Z","caller":"traceutil/trace.go:171","msg":"trace[1507991981] transaction","detail":"{read_only:false; response_revision:18679; number_of_response:1; }","duration":"517.36054ms","start":"2026-10-15T14:57:17.082656Z","end":"2026-10-15T14:57:17.600017Z","steps":["trace[1507991981] 'process raft request' (duration: 517.121234ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:57:17.600189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:57:17.082639Z","time spent":"517.467264ms","remote":"127.0.0.1:38376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20873,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T14:57:17.600221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.22071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-f2fmn\" ","response":"range_response_count:1 size:22128"} {"level":"info","ts":"2026-10-15T14:57:17.600262Z","caller":"traceutil/trace.go:171","msg":"trace[1584075633] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-f2fmn; range_end:; response_count:1; response_revision:18679; }","duration":"502.329933ms","start":"2026-10-15T14:57:17.097921Z","end":"2026-10-15T14:57:17.600251Z","steps":["trace[1584075633] 'agreement among raft nodes before linearized reading' (duration: 502.165949ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:57:17.600299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:57:17.097832Z","time spent":"502.458727ms","remote":"127.0.0.1:38376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22152,"request content":"key:\"/registry/pods/openstack/nova-compute-default-f2fmn\" "} {"level":"info","ts":"2026-10-15T14:57:17.858454Z","caller":"traceutil/trace.go:171","msg":"trace[860098051] transaction","detail":"{read_only:false; response_revision:18681; number_of_response:1; }","duration":"330.778893ms","start":"2026-10-15T14:57:17.527653Z","end":"2026-10-15T14:57:17.858432Z","steps":["trace[860098051] 'process raft request' (duration: 330.720251ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:57:17.858602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:57:17.527628Z","time spent":"330.892866ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T14:57:17.85896Z","caller":"traceutil/trace.go:171","msg":"trace[458591835] transaction","detail":"{read_only:false; response_revision:18680; number_of_response:1; }","duration":"724.384965ms","start":"2026-10-15T14:57:17.134563Z","end":"2026-10-15T14:57:17.858948Z","steps":["trace[458591835] 'process raft request' (duration: 723.675167ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:57:17.859026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:57:17.134537Z","time spent":"724.456497ms","remote":"127.0.0.1:53764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2789,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T14:57:17.859441Z","caller":"traceutil/trace.go:171","msg":"trace[796128500] linearizableReadLoop","detail":"{readStateIndex:19332; appliedIndex:19332; }","duration":"259.365433ms","start":"2026-10-15T14:57:17.600066Z","end":"2026-10-15T14:57:17.859432Z","steps":["trace[796128500] 'read index received' (duration: 259.359262ms)","trace[796128500] 'applied index is now lower than readState.Index' (duration: 5.02µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:57:17.859773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.003513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1866"} {"level":"info","ts":"2026-10-15T14:57:17.859852Z","caller":"traceutil/trace.go:171","msg":"trace[1091921922] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:18681; }","duration":"708.181857ms","start":"2026-10-15T14:57:17.15165Z","end":"2026-10-15T14:57:17.859832Z","steps":["trace[1091921922] 'agreement among raft nodes before linearized reading' (duration: 707.860699ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:57:17.8599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:57:17.151636Z","time spent":"708.254809ms","remote":"127.0.0.1:38330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1890,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-10-15T14:57:17.86026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.443211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:94 size:946773"} {"level":"info","ts":"2026-10-15T14:57:17.8603Z","caller":"traceutil/trace.go:171","msg":"trace[754669574] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:94; response_revision:18681; }","duration":"253.525463ms","start":"2026-10-15T14:57:17.606766Z","end":"2026-10-15T14:57:17.860291Z","steps":["trace[754669574] 'agreement among raft nodes before linearized reading' (duration: 252.730422ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:57:17.860478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.381916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-10-15T14:57:17.860499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.991962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-15T14:57:17.86052Z","caller":"traceutil/trace.go:171","msg":"trace[408341639] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:18681; }","duration":"733.446258ms","start":"2026-10-15T14:57:17.127062Z","end":"2026-10-15T14:57:17.860508Z","steps":["trace[408341639] 'agreement among raft nodes before linearized reading' (duration: 733.263604ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:57:17.860561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:57:17.127035Z","time spent":"733.518741ms","remote":"127.0.0.1:38450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"info","ts":"2026-10-15T14:57:17.860555Z","caller":"traceutil/trace.go:171","msg":"trace[236900271] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18681; }","duration":"290.140756ms","start":"2026-10-15T14:57:17.570399Z","end":"2026-10-15T14:57:17.860539Z","steps":["trace[236900271] 'agreement among raft nodes before linearized reading' (duration: 289.882409ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:57:17.860704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.693327ms","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-15T14:57:17.86074Z","caller":"traceutil/trace.go:171","msg":"trace[1319132331] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18681; }","duration":"194.783709ms","start":"2026-10-15T14:57:17.665948Z","end":"2026-10-15T14:57:17.860732Z","steps":["trace[1319132331] 'agreement among raft nodes before linearized reading' (duration: 194.676266ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:57:17.860766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.6537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-15T14:57:17.860817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.643919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-10-15T14:57:17.860869Z","caller":"traceutil/trace.go:171","msg":"trace[1303672236] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:18681; }","duration":"453.734821ms","start":"2026-10-15T14:57:17.407122Z","end":"2026-10-15T14:57:17.860856Z","steps":["trace[1303672236] 'agreement among raft nodes before linearized reading' (duration: 453.603668ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:57:17.86091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:57:17.407101Z","time spent":"453.798162ms","remote":"127.0.0.1:38376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-10-15T14:57:17.861066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.698573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T14:57:17.861122Z","caller":"traceutil/trace.go:171","msg":"trace[755268393] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18681; }","duration":"620.809346ms","start":"2026-10-15T14:57:17.240303Z","end":"2026-10-15T14:57:17.861112Z","steps":["trace[755268393] 'agreement among raft nodes before linearized reading' (duration: 620.717734ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:57:17.861148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:57:17.240239Z","time spent":"620.902279ms","remote":"127.0.0.1:38170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-15T14:57:17.860836Z","caller":"traceutil/trace.go:171","msg":"trace[70165802] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagerconfigs/; range_end:/registry/monitoring.coreos.com/alertmanagerconfigs0; response_count:0; response_revision:18681; }","duration":"715.732612ms","start":"2026-10-15T14:57:17.145061Z","end":"2026-10-15T14:57:17.860793Z","steps":["trace[70165802] 'agreement among raft nodes before linearized reading' (duration: 715.66186ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:57:17.861221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:57:17.145041Z","time spent":"716.164073ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true "} {"level":"warn","ts":"2026-10-15T14:57:17.860917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.271816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-mksj7\" ","response":"range_response_count:1 size:9799"} {"level":"info","ts":"2026-10-15T14:57:17.861527Z","caller":"traceutil/trace.go:171","msg":"trace[1897986158] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-mksj7; range_end:; response_count:1; response_revision:18681; }","duration":"201.924363ms","start":"2026-10-15T14:57:17.65959Z","end":"2026-10-15T14:57:17.861515Z","steps":["trace[1897986158] 'agreement among raft nodes before linearized reading' (duration: 201.267006ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:58:12.952905Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c5298098e2dc0f92","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-15T14:58:12.971841Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-15T14:58:12.971962Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-15T14:58:43.054513Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17106} {"level":"info","ts":"2026-10-15T14:58:43.159995Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17106,"took":"101.592955ms","hash":3885215140,"current-db-size-bytes":57118720,"current-db-size":"57 MB","current-db-size-in-use-bytes":33681408,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-15T14:58:43.160076Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3885215140,"revision":17106,"compact-revision":14659} {"level":"info","ts":"2026-10-15T15:03:08.645021Z","caller":"traceutil/trace.go:171","msg":"trace[550476084] transaction","detail":"{read_only:false; response_revision:21454; number_of_response:1; }","duration":"180.191472ms","start":"2026-10-15T15:03:08.464809Z","end":"2026-10-15T15:03:08.645Z","steps":["trace[550476084] 'process raft request' (duration: 178.88823ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:03:14.949758Z","caller":"traceutil/trace.go:171","msg":"trace[1190856009] linearizableReadLoop","detail":"{readStateIndex:22230; appliedIndex:22229; }","duration":"281.697705ms","start":"2026-10-15T15:03:14.668005Z","end":"2026-10-15T15:03:14.949703Z","steps":["trace[1190856009] 'read index received' (duration: 281.49179ms)","trace[1190856009] 'applied index is now lower than readState.Index' (duration: 205.095µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T15:03:14.949931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.089871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T15:03:14.949869Z","caller":"traceutil/trace.go:171","msg":"trace[1742820225] transaction","detail":"{read_only:false; response_revision:21487; number_of_response:1; }","duration":"283.717064ms","start":"2026-10-15T15:03:14.666111Z","end":"2026-10-15T15:03:14.949829Z","steps":["trace[1742820225] 'process raft request' (duration: 283.447538ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:03:14.950002Z","caller":"traceutil/trace.go:171","msg":"trace[1000174793] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:21487; }","duration":"267.217384ms","start":"2026-10-15T15:03:14.68277Z","end":"2026-10-15T15:03:14.949987Z","steps":["trace[1000174793] 'agreement among raft nodes before linearized reading' (duration: 267.100971ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:03:14.95034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.270969ms","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-15T15:03:14.950435Z","caller":"traceutil/trace.go:171","msg":"trace[525721141] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21487; }","duration":"282.466854ms","start":"2026-10-15T15:03:14.667946Z","end":"2026-10-15T15:03:14.950413Z","steps":["trace[525721141] 'agreement among raft nodes before linearized reading' (duration: 281.895331ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:03:15.215222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.598084ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-15T15:03:15.2154Z","caller":"traceutil/trace.go:171","msg":"trace[1162490595] linearizableReadLoop","detail":"{readStateIndex:22232; appliedIndex:22230; }","duration":"104.910666ms","start":"2026-10-15T15:03:15.110473Z","end":"2026-10-15T15:03:15.215383Z","steps":["trace[1162490595] 'read index received' (duration: 103.663125ms)","trace[1162490595] 'applied index is now lower than readState.Index' (duration: 1.246571ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T15:03:15.215482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.015428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T15:03:15.215518Z","caller":"traceutil/trace.go:171","msg":"trace[1843617673] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:21489; }","duration":"105.09289ms","start":"2026-10-15T15:03:15.110413Z","end":"2026-10-15T15:03:15.215506Z","steps":["trace[1843617673] 'agreement among raft nodes before linearized reading' (duration: 105.034918ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:03:15.215628Z","caller":"traceutil/trace.go:171","msg":"trace[573207730] transaction","detail":"{read_only:false; response_revision:21489; number_of_response:1; }","duration":"260.612494ms","start":"2026-10-15T15:03:14.954986Z","end":"2026-10-15T15:03:15.215599Z","steps":["trace[573207730] 'process raft request' (duration: 260.326027ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:03:15.215606Z","caller":"traceutil/trace.go:171","msg":"trace[1425493709] transaction","detail":"{read_only:false; response_revision:21488; number_of_response:1; }","duration":"261.873454ms","start":"2026-10-15T15:03:14.953703Z","end":"2026-10-15T15:03:15.215577Z","steps":["trace[1425493709] 'process raft request' (duration: 96.875871ms)","trace[1425493709] 'compare' (duration: 164.266096ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T15:03:15.954568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.739251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-15T15:03:15.954678Z","caller":"traceutil/trace.go:171","msg":"trace[4724002] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21491; }","duration":"174.897034ms","start":"2026-10-15T15:03:15.779756Z","end":"2026-10-15T15:03:15.954653Z","steps":["trace[4724002] 'range keys from in-memory index tree' (duration: 174.533255ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:03:15.955172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.643251ms","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-15T15:03:15.955273Z","caller":"traceutil/trace.go:171","msg":"trace[25570327] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21491; }","duration":"224.779634ms","start":"2026-10-15T15:03:15.730476Z","end":"2026-10-15T15:03:15.955255Z","steps":["trace[25570327] 'range keys from in-memory index tree' (duration: 224.438196ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:03:16.171835Z","caller":"traceutil/trace.go:171","msg":"trace[275798399] transaction","detail":"{read_only:false; response_revision:21492; number_of_response:1; }","duration":"212.302511ms","start":"2026-10-15T15:03:15.959508Z","end":"2026-10-15T15:03:16.171811Z","steps":["trace[275798399] 'process raft request' (duration: 212.144757ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:03:16.227599Z","caller":"traceutil/trace.go:171","msg":"trace[1794188308] transaction","detail":"{read_only:false; response_revision:21493; number_of_response:1; }","duration":"266.370363ms","start":"2026-10-15T15:03:15.961169Z","end":"2026-10-15T15:03:16.227539Z","steps":["trace[1794188308] 'process raft request' (duration: 266.258081ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:03:43.061567Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19568} {"level":"info","ts":"2026-10-15T15:03:43.181861Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19568,"took":"116.872026ms","hash":2060823171,"current-db-size-bytes":57118720,"current-db-size":"57 MB","current-db-size-in-use-bytes":29102080,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-15T15:03:43.18193Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2060823171,"revision":19568,"compact-revision":17106} {"level":"info","ts":"2026-10-15T15:04:30.94153Z","caller":"traceutil/trace.go:171","msg":"trace[662257704] linearizableReadLoop","detail":"{readStateIndex:22920; appliedIndex:22919; }","duration":"114.747095ms","start":"2026-10-15T15:04:30.826755Z","end":"2026-10-15T15:04:30.941502Z","steps":["trace[662257704] 'read index received' (duration: 114.513709ms)","trace[662257704] 'applied index is now lower than readState.Index' (duration: 232.036µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T15:04:30.941956Z","caller":"traceutil/trace.go:171","msg":"trace[129435253] transaction","detail":"{read_only:false; response_revision:22152; number_of_response:1; }","duration":"127.399751ms","start":"2026-10-15T15:04:30.81453Z","end":"2026-10-15T15:04:30.941929Z","steps":["trace[129435253] 'process raft request' (duration: 126.811297ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:04:30.942188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.41403ms","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-15T15:04:30.942302Z","caller":"traceutil/trace.go:171","msg":"trace[1440296262] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:22152; }","duration":"115.586485ms","start":"2026-10-15T15:04:30.826695Z","end":"2026-10-15T15:04:30.942281Z","steps":["trace[1440296262] 'agreement among raft nodes before linearized reading' (duration: 115.40462ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:07:23.243819Z","caller":"traceutil/trace.go:171","msg":"trace[1437565856] transaction","detail":"{read_only:false; response_revision:24065; number_of_response:1; }","duration":"148.242428ms","start":"2026-10-15T15:07:23.095547Z","end":"2026-10-15T15:07:23.24379Z","steps":["trace[1437565856] 'process raft request' (duration: 148.025852ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:07:23.695333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.634762ms","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-15T15:07:23.695484Z","caller":"traceutil/trace.go:171","msg":"trace[1206251508] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24065; }","duration":"212.824967ms","start":"2026-10-15T15:07:23.482641Z","end":"2026-10-15T15:07:23.695466Z","steps":["trace[1206251508] 'range keys from in-memory index tree' (duration: 212.486669ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:08:43.068014Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21636} {"level":"info","ts":"2026-10-15T15:08:43.184842Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21636,"took":"112.872585ms","hash":2513201255,"current-db-size-bytes":57118720,"current-db-size":"57 MB","current-db-size-in-use-bytes":43577344,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-10-15T15:08:43.184915Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2513201255,"revision":21636,"compact-revision":19568} {"level":"info","ts":"2026-10-15T15:09:58.099677Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006755.wal"} {"level":"warn","ts":"2026-10-15T15:10:41.980663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.844382ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-10-15T15:10:41.980896Z","caller":"traceutil/trace.go:171","msg":"trace[757748483] linearizableReadLoop","detail":"{readStateIndex:26911; appliedIndex:26910; }","duration":"349.614119ms","start":"2026-10-15T15:10:41.631263Z","end":"2026-10-15T15:10:41.980877Z","steps":["trace[757748483] 'read index received' (duration: 131.34349ms)","trace[757748483] 'applied index is now lower than readState.Index' (duration: 218.269479ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T15:10:41.98128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.001838ms","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-15T15:10:41.981337Z","caller":"traceutil/trace.go:171","msg":"trace[958106766] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26043; }","duration":"350.09952ms","start":"2026-10-15T15:10:41.631222Z","end":"2026-10-15T15:10:41.981321Z","steps":["trace[958106766] 'agreement among raft nodes before linearized reading' (duration: 349.938366ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:10:41.981378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:10:41.631203Z","time spent":"350.162591ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-15T15:10:41.981414Z","caller":"traceutil/trace.go:171","msg":"trace[452704559] transaction","detail":"{read_only:false; response_revision:26044; number_of_response:1; }","duration":"198.133022ms","start":"2026-10-15T15:10:41.783251Z","end":"2026-10-15T15:10:41.981384Z","steps":["trace[452704559] 'process raft request' (duration: 197.529417ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:10:42.204535Z","caller":"traceutil/trace.go:171","msg":"trace[272051099] linearizableReadLoop","detail":"{readStateIndex:26913; appliedIndex:26912; }","duration":"223.550936ms","start":"2026-10-15T15:10:41.980938Z","end":"2026-10-15T15:10:42.204489Z","steps":["trace[272051099] 'read index received' (duration: 223.482214ms)","trace[272051099] 'applied index is now lower than readState.Index' (duration: 67.202µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T15:10:42.204722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.733623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-15T15:10:42.204811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.566573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-15T15:10:42.20483Z","caller":"traceutil/trace.go:171","msg":"trace[963509754] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:26045; }","duration":"255.891986ms","start":"2026-10-15T15:10:41.948909Z","end":"2026-10-15T15:10:42.204801Z","steps":["trace[963509754] 'agreement among raft nodes before linearized reading' (duration: 255.726572ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:10:42.204871Z","caller":"traceutil/trace.go:171","msg":"trace[1383980571] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:26045; }","duration":"377.676046ms","start":"2026-10-15T15:10:41.827173Z","end":"2026-10-15T15:10:42.20485Z","steps":["trace[1383980571] 'agreement among raft nodes before linearized reading' (duration: 377.561063ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:10:42.204944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:10:41.827155Z","time spent":"377.774569ms","remote":"127.0.0.1:38698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":6,"response size":32,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-10-15T15:10:42.204687Z","caller":"traceutil/trace.go:171","msg":"trace[376960589] transaction","detail":"{read_only:false; response_revision:26045; number_of_response:1; }","duration":"282.361815ms","start":"2026-10-15T15:10:41.922303Z","end":"2026-10-15T15:10:42.204664Z","steps":["trace[376960589] 'process raft request' (duration: 281.786531ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:10:42.20518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.004062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-15T15:10:42.205274Z","caller":"traceutil/trace.go:171","msg":"trace[1197038661] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26045; }","duration":"571.126065ms","start":"2026-10-15T15:10:41.634123Z","end":"2026-10-15T15:10:42.205249Z","steps":["trace[1197038661] 'agreement among raft nodes before linearized reading' (duration: 570.843648ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:10:42.205319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:10:41.634113Z","time spent":"571.197117ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-15T15:10:42.205546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.548802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-15T15:10:42.206216Z","caller":"traceutil/trace.go:171","msg":"trace[1304636080] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:26045; }","duration":"431.257989ms","start":"2026-10-15T15:10:41.774938Z","end":"2026-10-15T15:10:42.206196Z","steps":["trace[1304636080] 'agreement among raft nodes before linearized reading' (duration: 429.951718ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:10:42.206284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:10:41.77492Z","time spent":"431.343951ms","remote":"127.0.0.1:38632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":32,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-10-15T15:10:42.36652Z","caller":"traceutil/trace.go:171","msg":"trace[567012575] transaction","detail":"{read_only:false; response_revision:26048; number_of_response:1; }","duration":"156.517128ms","start":"2026-10-15T15:10:42.209974Z","end":"2026-10-15T15:10:42.366491Z","steps":["trace[567012575] 'process raft request' (duration: 156.452676ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:10:42.366549Z","caller":"traceutil/trace.go:171","msg":"trace[1041099105] transaction","detail":"{read_only:false; response_revision:26046; number_of_response:1; }","duration":"379.592202ms","start":"2026-10-15T15:10:41.986924Z","end":"2026-10-15T15:10:42.366516Z","steps":["trace[1041099105] 'process raft request' (duration: 377.926191ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:10:42.366562Z","caller":"traceutil/trace.go:171","msg":"trace[532954205] linearizableReadLoop","detail":"{readStateIndex:26915; appliedIndex:26913; }","duration":"161.785595ms","start":"2026-10-15T15:10:42.204749Z","end":"2026-10-15T15:10:42.366535Z","steps":["trace[532954205] 'read index received' (duration: 159.266194ms)","trace[532954205] 'applied index is now lower than readState.Index' (duration: 2.516881ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T15:10:42.366738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.786485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T15:10:42.366779Z","caller":"traceutil/trace.go:171","msg":"trace[1590600376] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26048; }","duration":"125.874398ms","start":"2026-10-15T15:10:42.240895Z","end":"2026-10-15T15:10:42.36677Z","steps":["trace[1590600376] 'agreement among raft nodes before linearized reading' (duration: 125.779095ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:10:42.366799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:10:41.986902Z","time spent":"379.717505ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T15:10:42.3668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.895739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-10-15T15:10:42.366918Z","caller":"traceutil/trace.go:171","msg":"trace[647375560] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26048; }","duration":"247.061304ms","start":"2026-10-15T15:10:42.119825Z","end":"2026-10-15T15:10:42.366887Z","steps":["trace[647375560] 'agreement among raft nodes before linearized reading' (duration: 246.766816ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:10:42.367154Z","caller":"traceutil/trace.go:171","msg":"trace[791132941] transaction","detail":"{read_only:false; response_revision:26047; number_of_response:1; }","duration":"314.473381ms","start":"2026-10-15T15:10:42.052661Z","end":"2026-10-15T15:10:42.367134Z","steps":["trace[791132941] 'process raft request' (duration: 313.696682ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:10:42.368139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:10:42.052634Z","time spent":"314.601123ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T15:10:42.748325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.468018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"} {"level":"info","ts":"2026-10-15T15:10:42.748414Z","caller":"traceutil/trace.go:171","msg":"trace[2082934193] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:26048; }","duration":"275.635863ms","start":"2026-10-15T15:10:42.472757Z","end":"2026-10-15T15:10:42.748392Z","steps":["trace[2082934193] 'range keys from in-memory index tree' (duration: 275.221893ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:10:42.748522Z","caller":"traceutil/trace.go:171","msg":"trace[1353160919] transaction","detail":"{read_only:false; response_revision:26049; number_of_response:1; }","duration":"204.724861ms","start":"2026-10-15T15:10:42.543763Z","end":"2026-10-15T15:10:42.748488Z","steps":["trace[1353160919] 'process raft request' (duration: 191.763608ms)","trace[1353160919] 'compare' (duration: 12.573024ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T15:10:42.966004Z","caller":"traceutil/trace.go:171","msg":"trace[1652364748] transaction","detail":"{read_only:false; response_revision:26050; number_of_response:1; }","duration":"212.651172ms","start":"2026-10-15T15:10:42.753311Z","end":"2026-10-15T15:10:42.965963Z","steps":["trace[1652364748] 'process raft request' (duration: 179.570264ms)","trace[1652364748] 'compare' (duration: 32.960215ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T15:10:42.968804Z","caller":"traceutil/trace.go:171","msg":"trace[1699283856] transaction","detail":"{read_only:false; response_revision:26051; number_of_response:1; }","duration":"215.278767ms","start":"2026-10-15T15:10:42.753502Z","end":"2026-10-15T15:10:42.968781Z","steps":["trace[1699283856] 'process raft request' (duration: 215.086532ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:10:42.969019Z","caller":"traceutil/trace.go:171","msg":"trace[145101327] transaction","detail":"{read_only:false; response_revision:26052; number_of_response:1; }","duration":"203.00354ms","start":"2026-10-15T15:10:42.765984Z","end":"2026-10-15T15:10:42.968988Z","steps":["trace[145101327] 'process raft request' (duration: 202.740043ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:31.938768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.548546ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-10-15T15:11:38.550811Z","caller":"traceutil/trace.go:171","msg":"trace[1741480948] linearizableReadLoop","detail":"{readStateIndex:27447; appliedIndex:27446; }","duration":"311.482991ms","start":"2026-10-15T15:11:38.239303Z","end":"2026-10-15T15:11:38.550786Z","steps":["trace[1741480948] 'read index received' (duration: 311.255616ms)","trace[1741480948] 'applied index is now lower than readState.Index' (duration: 226.335µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T15:11:38.550927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.607664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T15:11:38.550958Z","caller":"traceutil/trace.go:171","msg":"trace[1938837426] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26567; }","duration":"311.682936ms","start":"2026-10-15T15:11:38.239265Z","end":"2026-10-15T15:11:38.550948Z","steps":["trace[1938837426] 'agreement among raft nodes before linearized reading' (duration: 311.615004ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:38.550997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:38.239245Z","time spent":"311.743718ms","remote":"127.0.0.1:38170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-15T15:11:38.551051Z","caller":"traceutil/trace.go:171","msg":"trace[2071557010] transaction","detail":"{read_only:false; response_revision:26567; number_of_response:1; }","duration":"332.781052ms","start":"2026-10-15T15:11:38.218252Z","end":"2026-10-15T15:11:38.551033Z","steps":["trace[2071557010] 'process raft request' (duration: 332.354212ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:38.551167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:38.218224Z","time spent":"332.873014ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T15:11:43.914397Z","caller":"traceutil/trace.go:171","msg":"trace[1456317555] transaction","detail":"{read_only:false; response_revision:26606; number_of_response:1; }","duration":"386.105879ms","start":"2026-10-15T15:11:43.528262Z","end":"2026-10-15T15:11:43.914368Z","steps":["trace[1456317555] 'process raft request' (duration: 385.924794ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:43.914549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:43.528234Z","time spent":"386.238922ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T15:11:44.887269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.889545ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-15T15:11:44.887598Z","caller":"traceutil/trace.go:171","msg":"trace[254673906] linearizableReadLoop","detail":"{readStateIndex:27492; appliedIndex:27486; }","duration":"996.197133ms","start":"2026-10-15T15:11:43.891381Z","end":"2026-10-15T15:11:44.887578Z","steps":["trace[254673906] 'read index received' (duration: 22.787306ms)","trace[254673906] 'applied index is now lower than readState.Index' (duration: 973.408407ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T15:11:44.887673Z","caller":"traceutil/trace.go:171","msg":"trace[292401606] transaction","detail":"{read_only:false; response_revision:26607; number_of_response:1; }","duration":"1.274897379s","start":"2026-10-15T15:11:43.612762Z","end":"2026-10-15T15:11:44.88766Z","steps":["trace[292401606] 'process raft request' (duration: 1.128511722s)","trace[292401606] 'compare' (duration: 145.516616ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T15:11:44.887711Z","caller":"traceutil/trace.go:171","msg":"trace[1261677519] transaction","detail":"{read_only:false; response_revision:26609; number_of_response:1; }","duration":"1.220381353s","start":"2026-10-15T15:11:43.667288Z","end":"2026-10-15T15:11:44.88767Z","steps":["trace[1261677519] 'process raft request' (duration: 1.220176398s)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:44.887725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:43.612737Z","time spent":"1.27495613s","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T15:11:44.887722Z","caller":"traceutil/trace.go:171","msg":"trace[1481580710] transaction","detail":"{read_only:false; response_revision:26611; number_of_response:1; }","duration":"1.098104724s","start":"2026-10-15T15:11:43.789575Z","end":"2026-10-15T15:11:44.88768Z","steps":["trace[1481580710] 'process raft request' (duration: 1.097960781s)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:44.88778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"996.379007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-15T15:11:44.887829Z","caller":"traceutil/trace.go:171","msg":"trace[648430564] transaction","detail":"{read_only:false; response_revision:26608; number_of_response:1; }","duration":"1.257656246s","start":"2026-10-15T15:11:43.630163Z","end":"2026-10-15T15:11:44.887819Z","steps":["trace[648430564] 'process raft request' (duration: 1.257235226s)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:11:44.887856Z","caller":"traceutil/trace.go:171","msg":"trace[87758687] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:26611; }","duration":"996.53036ms","start":"2026-10-15T15:11:43.891308Z","end":"2026-10-15T15:11:44.887839Z","steps":["trace[87758687] 'agreement among raft nodes before linearized reading' (duration: 996.358736ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:44.88788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:43.630141Z","time spent":"1.257712628s","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T15:11:44.887899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:43.891289Z","time spent":"996.600662ms","remote":"127.0.0.1:38454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":4,"response size":32,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"info","ts":"2026-10-15T15:11:44.888019Z","caller":"traceutil/trace.go:171","msg":"trace[637562623] transaction","detail":"{read_only:false; response_revision:26610; number_of_response:1; }","duration":"1.214387529s","start":"2026-10-15T15:11:43.673607Z","end":"2026-10-15T15:11:44.887995Z","steps":["trace[637562623] 'process raft request' (duration: 1.213894067s)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:44.888165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:43.673599Z","time spent":"1.214469281s","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T15:11:44.888206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:43.789559Z","time spent":"1.098531534s","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T15:11:44.887793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:43.667271Z","time spent":"1.220480135s","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T15:11:45.387752Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1122136553116136421,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-15T15:11:45.972332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.50953ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-15T15:11:45.972621Z","caller":"traceutil/trace.go:171","msg":"trace[413976361] transaction","detail":"{read_only:false; response_revision:26612; number_of_response:1; }","duration":"1.386566053s","start":"2026-10-15T15:11:44.585996Z","end":"2026-10-15T15:11:45.972562Z","steps":["trace[413976361] 'process raft request' (duration: 1.102692534s)","trace[413976361] 'compare' (duration: 282.447884ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T15:11:45.972656Z","caller":"traceutil/trace.go:171","msg":"trace[1083075682] transaction","detail":"{read_only:false; response_revision:26613; number_of_response:1; }","duration":"1.256327013s","start":"2026-10-15T15:11:44.716315Z","end":"2026-10-15T15:11:45.972642Z","steps":["trace[1083075682] 'process raft request' (duration: 1.25616917s)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:45.972719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:44.716291Z","time spent":"1.256392924s","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T15:11:45.972721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:44.585973Z","time spent":"1.386700736s","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T15:11:45.993639Z","caller":"traceutil/trace.go:171","msg":"trace[4642119] linearizableReadLoop","detail":"{readStateIndex:27496; appliedIndex:27492; }","duration":"1.105997142s","start":"2026-10-15T15:11:44.887627Z","end":"2026-10-15T15:11:45.993624Z","steps":["trace[4642119] 'read index received' (duration: 800.671999ms)","trace[4642119] 'applied index is now lower than readState.Index' (duration: 305.324263ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T15:11:45.99366Z","caller":"traceutil/trace.go:171","msg":"trace[259416011] transaction","detail":"{read_only:false; response_revision:26614; number_of_response:1; }","duration":"916.030381ms","start":"2026-10-15T15:11:45.077605Z","end":"2026-10-15T15:11:45.993636Z","steps":["trace[259416011] 'process raft request' (duration: 915.838047ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:11:45.99374Z","caller":"traceutil/trace.go:171","msg":"trace[360956052] transaction","detail":"{read_only:false; response_revision:26615; number_of_response:1; }","duration":"739.066442ms","start":"2026-10-15T15:11:45.254642Z","end":"2026-10-15T15:11:45.993709Z","steps":["trace[360956052] 'process raft request' (duration: 738.915079ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:45.993796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:45.077582Z","time spent":"916.148615ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T15:11:45.993809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:45.254621Z","time spent":"739.144835ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T15:11:45.993889Z","caller":"traceutil/trace.go:171","msg":"trace[1787916701] transaction","detail":"{read_only:false; response_revision:26616; number_of_response:1; }","duration":"564.981023ms","start":"2026-10-15T15:11:45.4289Z","end":"2026-10-15T15:11:45.993881Z","steps":["trace[1787916701] 'process raft request' (duration: 564.690836ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:45.993936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:45.428871Z","time spent":"565.042204ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T15:11:45.99409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.868996048s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-10-15T15:11:45.994113Z","caller":"traceutil/trace.go:171","msg":"trace[829994109] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26616; }","duration":"1.86906072s","start":"2026-10-15T15:11:44.125046Z","end":"2026-10-15T15:11:45.994107Z","steps":["trace[829994109] 'agreement among raft nodes before linearized reading' (duration: 1.868971388s)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:45.994127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:44.125027Z","time spent":"1.869096721s","remote":"127.0.0.1:38376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-10-15T15:11:45.994136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.890136335s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/endpoints/\" range_end:\"/registry/openstack.k-orc.cloud/endpoints0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T15:11:45.994167Z","caller":"traceutil/trace.go:171","msg":"trace[1466049984] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/endpoints/; range_end:/registry/openstack.k-orc.cloud/endpoints0; response_count:0; response_revision:26616; }","duration":"1.890203367s","start":"2026-10-15T15:11:44.103953Z","end":"2026-10-15T15:11:45.994156Z","steps":["trace[1466049984] 'agreement among raft nodes before linearized reading' (duration: 1.890148406s)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:45.994202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:44.103935Z","time spent":"1.890259768s","remote":"127.0.0.1:33364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":30,"request content":"key:\"/registry/openstack.k-orc.cloud/endpoints/\" range_end:\"/registry/openstack.k-orc.cloud/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-10-15T15:11:45.994222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.560199842s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-10-15T15:11:45.994235Z","caller":"traceutil/trace.go:171","msg":"trace[1116673690] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:26616; }","duration":"1.560247224s","start":"2026-10-15T15:11:44.433983Z","end":"2026-10-15T15:11:45.994231Z","steps":["trace[1116673690] 'agreement among raft nodes before linearized reading' (duration: 1.560206573s)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:45.994246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:44.433964Z","time spent":"1.560279164s","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":557,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-10-15T15:11:45.994322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.680560885s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T15:11:45.994337Z","caller":"traceutil/trace.go:171","msg":"trace[1602960268] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:26616; }","duration":"1.680641627s","start":"2026-10-15T15:11:44.313692Z","end":"2026-10-15T15:11:45.994333Z","steps":["trace[1602960268] 'agreement among raft nodes before linearized reading' (duration: 1.680614027s)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:45.994362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:44.313673Z","time spent":"1.680685808s","remote":"127.0.0.1:38596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":30,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"warn","ts":"2026-10-15T15:11:45.994429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.959084557s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T15:11:45.994473Z","caller":"traceutil/trace.go:171","msg":"trace[1901818569] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:26616; }","duration":"1.959166358s","start":"2026-10-15T15:11:44.035294Z","end":"2026-10-15T15:11:45.99446Z","steps":["trace[1901818569] 'agreement among raft nodes before linearized reading' (duration: 1.959099637s)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:45.994505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:44.035273Z","time spent":"1.95922395s","remote":"127.0.0.1:41538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":30,"request content":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true "} {"level":"warn","ts":"2026-10-15T15:11:45.994619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.037207768s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-15T15:11:45.994666Z","caller":"traceutil/trace.go:171","msg":"trace[191691231] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:26616; }","duration":"2.03729233s","start":"2026-10-15T15:11:43.957366Z","end":"2026-10-15T15:11:45.994659Z","steps":["trace[191691231] 'agreement among raft nodes before linearized reading' (duration: 2.037231789s)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:45.994681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:43.957329Z","time spent":"2.037347121s","remote":"127.0.0.1:42294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":6,"response size":32,"request content":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true "} {"level":"warn","ts":"2026-10-15T15:11:46.494317Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1122136553116136426,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-15T15:11:46.726966Z","caller":"traceutil/trace.go:171","msg":"trace[1299659888] transaction","detail":"{read_only:false; response_revision:26617; number_of_response:1; }","duration":"976.869789ms","start":"2026-10-15T15:11:45.75007Z","end":"2026-10-15T15:11:46.72694Z","steps":["trace[1299659888] 'process raft request' (duration: 932.732431ms)","trace[1299659888] 'compare' (duration: 43.503022ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T15:11:46.727174Z","caller":"traceutil/trace.go:171","msg":"trace[1178361814] linearizableReadLoop","detail":"{readStateIndex:27499; appliedIndex:27497; }","duration":"733.463828ms","start":"2026-10-15T15:11:45.99368Z","end":"2026-10-15T15:11:46.727144Z","steps":["trace[1178361814] 'read index received' (duration: 689.105076ms)","trace[1178361814] 'applied index is now lower than readState.Index' (duration: 44.357102ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T15:11:46.727251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:45.75004Z","time spent":"976.992022ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T15:11:46.727436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.00364062s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-15T15:11:46.727482Z","caller":"traceutil/trace.go:171","msg":"trace[287736468] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:26618; }","duration":"1.003730922s","start":"2026-10-15T15:11:45.723738Z","end":"2026-10-15T15:11:46.727469Z","steps":["trace[287736468] 'agreement among raft nodes before linearized reading' (duration: 1.003573328s)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:46.727525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:45.723719Z","time spent":"1.003796273s","remote":"127.0.0.1:38634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":32,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-10-15T15:11:46.727598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"939.292059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-15T15:11:46.727773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.811982372s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-10-15T15:11:46.727801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.804212387s","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-15T15:11:46.727785Z","caller":"traceutil/trace.go:171","msg":"trace[2058803062] transaction","detail":"{read_only:false; response_revision:26618; number_of_response:1; }","duration":"729.035223ms","start":"2026-10-15T15:11:45.998715Z","end":"2026-10-15T15:11:46.72775Z","steps":["trace[2058803062] 'process raft request' (duration: 728.147022ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:11:46.727856Z","caller":"traceutil/trace.go:171","msg":"trace[796848820] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26618; }","duration":"1.804266648s","start":"2026-10-15T15:11:44.923573Z","end":"2026-10-15T15:11:46.72784Z","steps":["trace[796848820] 'agreement among raft nodes before linearized reading' (duration: 1.804080344s)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:46.727913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:44.92351Z","time spent":"1.804393772s","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-15T15:11:46.727901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.142375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-10-15T15:11:46.727961Z","caller":"traceutil/trace.go:171","msg":"trace[709425378] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26618; }","duration":"729.245188ms","start":"2026-10-15T15:11:45.9987Z","end":"2026-10-15T15:11:46.727945Z","steps":["trace[709425378] 'agreement among raft nodes before linearized reading' (duration: 729.071793ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:46.727967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:45.998696Z","time spent":"729.170156ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T15:11:46.727979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.48748606s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-15T15:11:46.728209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.625613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T15:11:46.728253Z","caller":"traceutil/trace.go:171","msg":"trace[134088743] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:26618; }","duration":"126.688475ms","start":"2026-10-15T15:11:46.601551Z","end":"2026-10-15T15:11:46.72824Z","steps":["trace[134088743] 'agreement among raft nodes before linearized reading' (duration: 126.626613ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:46.728253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.548818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.82\" ","response":"range_response_count:1 size:137"} {"level":"warn","ts":"2026-10-15T15:11:46.728012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:45.99868Z","time spent":"729.32019ms","remote":"127.0.0.1:38376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-10-15T15:11:46.728273Z","caller":"traceutil/trace.go:171","msg":"trace[1820576606] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26618; }","duration":"1.812509305s","start":"2026-10-15T15:11:44.915745Z","end":"2026-10-15T15:11:46.728254Z","steps":["trace[1820576606] 'agreement among raft nodes before linearized reading' (duration: 1.811930901s)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:46.72828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.519163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T15:11:46.728293Z","caller":"traceutil/trace.go:171","msg":"trace[798892747] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26618; }","duration":"1.487843849s","start":"2026-10-15T15:11:45.240431Z","end":"2026-10-15T15:11:46.728275Z","steps":["trace[798892747] 'agreement among raft nodes before linearized reading' (duration: 1.48748768s)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:11:46.728299Z","caller":"traceutil/trace.go:171","msg":"trace[98761531] range","detail":"{range_begin:/registry/masterleases/162.253.55.82; range_end:; response_count:1; response_revision:26618; }","duration":"153.62865ms","start":"2026-10-15T15:11:46.574657Z","end":"2026-10-15T15:11:46.728286Z","steps":["trace[98761531] 'agreement among raft nodes before linearized reading' (duration: 153.503867ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:46.728227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.329191218s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-10-15T15:11:46.728444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.275819209s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-10-15T15:11:46.728488Z","caller":"traceutil/trace.go:171","msg":"trace[114713562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26618; }","duration":"1.27585841s","start":"2026-10-15T15:11:45.452617Z","end":"2026-10-15T15:11:46.728476Z","steps":["trace[114713562] 'agreement among raft nodes before linearized reading' (duration: 1.275537893s)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:46.728511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:45.452571Z","time spent":"1.275934942s","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-15T15:11:46.728488Z","caller":"traceutil/trace.go:171","msg":"trace[836596117] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26618; }","duration":"1.329553837s","start":"2026-10-15T15:11:45.398913Z","end":"2026-10-15T15:11:46.728467Z","steps":["trace[836596117] 'agreement among raft nodes before linearized reading' (duration: 1.32883085s)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:46.728332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:44.915723Z","time spent":"1.812593598s","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-10-15T15:11:46.727753Z","caller":"traceutil/trace.go:171","msg":"trace[1968508521] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:26618; }","duration":"939.574745ms","start":"2026-10-15T15:11:45.788151Z","end":"2026-10-15T15:11:46.727726Z","steps":["trace[1968508521] 'agreement among raft nodes before linearized reading' (duration: 939.076303ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:46.728648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:45.788128Z","time spent":"940.492987ms","remote":"127.0.0.1:52676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true "} {"level":"warn","ts":"2026-10-15T15:11:46.728363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:45.240412Z","time spent":"1.48792038s","remote":"127.0.0.1:38170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-15T15:11:46.728357Z","caller":"traceutil/trace.go:171","msg":"trace[611403964] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:26618; }","duration":"372.660897ms","start":"2026-10-15T15:11:46.355661Z","end":"2026-10-15T15:11:46.728322Z","steps":["trace[611403964] 'agreement among raft nodes before linearized reading' (duration: 372.515463ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:46.728792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:46.35564Z","time spent":"373.130177ms","remote":"127.0.0.1:41540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":30,"request content":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true "} {"level":"warn","ts":"2026-10-15T15:11:46.728328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.804852ms","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-15T15:11:46.728914Z","caller":"traceutil/trace.go:171","msg":"trace[487943554] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:26618; }","duration":"715.365915ms","start":"2026-10-15T15:11:46.013488Z","end":"2026-10-15T15:11:46.728854Z","steps":["trace[487943554] 'agreement among raft nodes before linearized reading' (duration: 714.693449ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:46.728978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:46.013475Z","time spent":"715.480229ms","remote":"127.0.0.1:38268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":381,"request content":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" "} {"level":"warn","ts":"2026-10-15T15:11:46.728247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.347391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-15T15:11:46.729097Z","caller":"traceutil/trace.go:171","msg":"trace[1419658333] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26618; }","duration":"811.229972ms","start":"2026-10-15T15:11:45.917848Z","end":"2026-10-15T15:11:46.729078Z","steps":["trace[1419658333] 'agreement among raft nodes before linearized reading' (duration: 810.289619ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:46.729178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:45.917829Z","time spent":"811.326724ms","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-15T15:11:46.729207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T15:11:45.398859Z","time spent":"1.32970096s","remote":"127.0.0.1:38446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-10-15T15:11:46.848602Z","caller":"traceutil/trace.go:171","msg":"trace[1792840884] linearizableReadLoop","detail":"{readStateIndex:27500; appliedIndex:27499; }","duration":"118.593861ms","start":"2026-10-15T15:11:46.72998Z","end":"2026-10-15T15:11:46.848573Z","steps":["trace[1792840884] 'read index received' (duration: 112.496495ms)","trace[1792840884] 'applied index is now lower than readState.Index' (duration: 6.095866ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T15:11:46.848888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.883598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19029"} {"level":"info","ts":"2026-10-15T15:11:46.848951Z","caller":"traceutil/trace.go:171","msg":"trace[1777847750] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:26618; }","duration":"118.98807ms","start":"2026-10-15T15:11:46.729946Z","end":"2026-10-15T15:11:46.848934Z","steps":["trace[1777847750] 'agreement among raft nodes before linearized reading' (duration: 118.760155ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:11:46.853364Z","caller":"traceutil/trace.go:171","msg":"trace[316974227] transaction","detail":"{read_only:false; response_revision:26619; number_of_response:1; }","duration":"120.608889ms","start":"2026-10-15T15:11:46.732717Z","end":"2026-10-15T15:11:46.853326Z","steps":["trace[316974227] 'process raft request' (duration: 120.375114ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:11:46.853479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.272953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T15:11:46.853507Z","caller":"traceutil/trace.go:171","msg":"trace[1346371493] transaction","detail":"{read_only:false; response_revision:26621; number_of_response:1; }","duration":"119.464212ms","start":"2026-10-15T15:11:46.734015Z","end":"2026-10-15T15:11:46.853479Z","steps":["trace[1346371493] 'process raft request' (duration: 119.252907ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:11:46.853556Z","caller":"traceutil/trace.go:171","msg":"trace[1032918756] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26623; }","duration":"123.410136ms","start":"2026-10-15T15:11:46.730127Z","end":"2026-10-15T15:11:46.853537Z","steps":["trace[1032918756] 'agreement among raft nodes before linearized reading' (duration: 123.246382ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:11:46.853564Z","caller":"traceutil/trace.go:171","msg":"trace[340480115] transaction","detail":"{read_only:false; response_revision:26620; number_of_response:1; }","duration":"120.069746ms","start":"2026-10-15T15:11:46.733467Z","end":"2026-10-15T15:11:46.853537Z","steps":["trace[340480115] 'process raft request' (duration: 119.767079ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:11:46.853577Z","caller":"traceutil/trace.go:171","msg":"trace[1820380409] transaction","detail":"{read_only:false; response_revision:26622; number_of_response:1; }","duration":"119.178195ms","start":"2026-10-15T15:11:46.734378Z","end":"2026-10-15T15:11:46.853556Z","steps":["trace[1820380409] 'process raft request' (duration: 118.918169ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:11:46.853611Z","caller":"traceutil/trace.go:171","msg":"trace[2067223701] transaction","detail":"{read_only:false; response_revision:26623; number_of_response:1; }","duration":"118.694104ms","start":"2026-10-15T15:11:46.73489Z","end":"2026-10-15T15:11:46.853584Z","steps":["trace[2067223701] 'process raft request' (duration: 118.432647ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:13:05.366789Z","caller":"traceutil/trace.go:171","msg":"trace[623356078] transaction","detail":"{read_only:false; response_revision:27374; number_of_response:1; }","duration":"197.335448ms","start":"2026-10-15T15:13:05.169431Z","end":"2026-10-15T15:13:05.366766Z","steps":["trace[623356078] 'process raft request' (duration: 197.175404ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:13:05.368675Z","caller":"traceutil/trace.go:171","msg":"trace[950693151] linearizableReadLoop","detail":"{readStateIndex:28276; appliedIndex:28273; }","duration":"129.105333ms","start":"2026-10-15T15:13:05.239547Z","end":"2026-10-15T15:13:05.368652Z","steps":["trace[950693151] 'read index received' (duration: 127.050384ms)","trace[950693151] 'applied index is now lower than readState.Index' (duration: 2.054099ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T15:13:05.368717Z","caller":"traceutil/trace.go:171","msg":"trace[18781614] transaction","detail":"{read_only:false; response_revision:27375; number_of_response:1; }","duration":"188.082826ms","start":"2026-10-15T15:13:05.180617Z","end":"2026-10-15T15:13:05.3687Z","steps":["trace[18781614] 'process raft request' (duration: 187.893321ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:13:05.368799Z","caller":"traceutil/trace.go:171","msg":"trace[955919847] transaction","detail":"{read_only:false; response_revision:27376; number_of_response:1; }","duration":"187.296117ms","start":"2026-10-15T15:13:05.18149Z","end":"2026-10-15T15:13:05.368786Z","steps":["trace[955919847] 'process raft request' (duration: 187.125793ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:13:05.369063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.907509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-15T15:13:05.369168Z","caller":"traceutil/trace.go:171","msg":"trace[1252824122] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:27376; }","duration":"109.058493ms","start":"2026-10-15T15:13:05.260097Z","end":"2026-10-15T15:13:05.369156Z","steps":["trace[1252824122] 'agreement among raft nodes before linearized reading' (duration: 108.902699ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:13:05.369468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.917272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T15:13:05.369519Z","caller":"traceutil/trace.go:171","msg":"trace[1504611034] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27376; }","duration":"130.017184ms","start":"2026-10-15T15:13:05.239489Z","end":"2026-10-15T15:13:05.369507Z","steps":["trace[1504611034] 'agreement among raft nodes before linearized reading' (duration: 129.934712ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:13:05.36984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.629826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T15:13:05.369876Z","caller":"traceutil/trace.go:171","msg":"trace[479431465] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:27376; }","duration":"109.666427ms","start":"2026-10-15T15:13:05.260198Z","end":"2026-10-15T15:13:05.369865Z","steps":["trace[479431465] 'agreement among raft nodes before linearized reading' (duration: 109.611036ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:13:43.077264Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24935} {"level":"info","ts":"2026-10-15T15:13:43.248474Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24935,"took":"166.602251ms","hash":546470705,"current-db-size-bytes":57540608,"current-db-size":"58 MB","current-db-size-in-use-bytes":36651008,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-10-15T15:13:43.248554Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":546470705,"revision":24935,"compact-revision":21636} {"level":"info","ts":"2026-10-15T15:15:13.680416Z","caller":"traceutil/trace.go:171","msg":"trace[1597549498] transaction","detail":"{read_only:false; response_revision:28680; number_of_response:1; }","duration":"108.186982ms","start":"2026-10-15T15:15:13.572202Z","end":"2026-10-15T15:15:13.680389Z","steps":["trace[1597549498] 'process raft request' (duration: 108.029088ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:15:50.032214Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c5298098e2dc0f92","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-15T15:15:50.04135Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-15T15:15:50.041466Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-15T15:18:43.08554Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27724} {"level":"info","ts":"2026-10-15T15:18:43.236163Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27724,"took":"146.590961ms","hash":2639034696,"current-db-size-bytes":57962496,"current-db-size":"58 MB","current-db-size-in-use-bytes":34115584,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-15T15:18:43.236236Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2639034696,"revision":27724,"compact-revision":24935} {"level":"info","ts":"2026-10-15T15:18:59.357807Z","caller":"traceutil/trace.go:171","msg":"trace[185942097] transaction","detail":"{read_only:false; response_revision:30468; number_of_response:1; }","duration":"121.222877ms","start":"2026-10-15T15:18:59.236554Z","end":"2026-10-15T15:18:59.357777Z","steps":["trace[185942097] 'process raft request' (duration: 121.018222ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:18:59.365265Z","caller":"traceutil/trace.go:171","msg":"trace[1257098740] transaction","detail":"{read_only:false; response_revision:30469; number_of_response:1; }","duration":"127.401285ms","start":"2026-10-15T15:18:59.237829Z","end":"2026-10-15T15:18:59.365231Z","steps":["trace[1257098740] 'process raft request' (duration: 127.165299ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:23:43.092851Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30348} {"level":"info","ts":"2026-10-15T15:23:43.248147Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30348,"took":"151.143841ms","hash":2632572279,"current-db-size-bytes":57962496,"current-db-size":"58 MB","current-db-size-in-use-bytes":30593024,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-15T15:23:43.248204Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2632572279,"revision":30348,"compact-revision":27724} {"level":"info","ts":"2026-10-15T15:24:33.261166Z","caller":"traceutil/trace.go:171","msg":"trace[306934620] transaction","detail":"{read_only:false; response_revision:32968; number_of_response:1; }","duration":"167.064114ms","start":"2026-10-15T15:24:33.094079Z","end":"2026-10-15T15:24:33.261143Z","steps":["trace[306934620] 'process raft request' (duration: 166.927081ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:24:33.27801Z","caller":"traceutil/trace.go:171","msg":"trace[1374643730] transaction","detail":"{read_only:false; response_revision:32969; number_of_response:1; }","duration":"175.997407ms","start":"2026-10-15T15:24:33.101983Z","end":"2026-10-15T15:24:33.27798Z","steps":["trace[1374643730] 'process raft request' (duration: 175.811962ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:24:33.278509Z","caller":"traceutil/trace.go:171","msg":"trace[1379512610] linearizableReadLoop","detail":"{readStateIndex:34026; appliedIndex:34024; }","duration":"128.241451ms","start":"2026-10-15T15:24:33.150241Z","end":"2026-10-15T15:24:33.278482Z","steps":["trace[1379512610] 'read index received' (duration: 110.817786ms)","trace[1379512610] 'applied index is now lower than readState.Index' (duration: 17.421884ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T15:24:33.278729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.458485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-10-15T15:24:33.279679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.176679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T15:24:33.27975Z","caller":"traceutil/trace.go:171","msg":"trace[1520341490] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:32972; }","duration":"120.310952ms","start":"2026-10-15T15:24:33.159419Z","end":"2026-10-15T15:24:33.27973Z","steps":["trace[1520341490] 'agreement among raft nodes before linearized reading' (duration: 120.165369ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:24:33.280152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.572603ms","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-15T15:24:33.280184Z","caller":"traceutil/trace.go:171","msg":"trace[1873399814] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:32972; }","duration":"116.652625ms","start":"2026-10-15T15:24:33.163522Z","end":"2026-10-15T15:24:33.280175Z","steps":["trace[1873399814] 'agreement among raft nodes before linearized reading' (duration: 116.562043ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:24:33.280407Z","caller":"traceutil/trace.go:171","msg":"trace[1964238972] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:32972; }","duration":"129.321066ms","start":"2026-10-15T15:24:33.150182Z","end":"2026-10-15T15:24:33.279503Z","steps":["trace[1964238972] 'agreement among raft nodes before linearized reading' (duration: 128.428825ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:24:34.338975Z","caller":"traceutil/trace.go:171","msg":"trace[844105417] transaction","detail":"{read_only:false; response_revision:32979; number_of_response:1; }","duration":"111.562973ms","start":"2026-10-15T15:24:34.227383Z","end":"2026-10-15T15:24:34.338946Z","steps":["trace[844105417] 'process raft request' (duration: 84.10276ms)","trace[844105417] 'compare' (duration: 27.259009ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T15:24:35.408438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.216702ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-15T15:24:35.408665Z","caller":"traceutil/trace.go:171","msg":"trace[1307195422] transaction","detail":"{read_only:false; response_revision:32982; number_of_response:1; }","duration":"124.44037ms","start":"2026-10-15T15:24:35.284212Z","end":"2026-10-15T15:24:35.408652Z","steps":["trace[1307195422] 'process raft request' (duration: 21.624904ms)","trace[1307195422] 'compare' (duration: 102.012177ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T15:24:35.408774Z","caller":"traceutil/trace.go:171","msg":"trace[1582368979] transaction","detail":"{read_only:false; response_revision:32983; number_of_response:1; }","duration":"124.385229ms","start":"2026-10-15T15:24:35.284384Z","end":"2026-10-15T15:24:35.408769Z","steps":["trace[1582368979] 'process raft request' (duration: 124.142093ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:24:35.408829Z","caller":"traceutil/trace.go:171","msg":"trace[1180713501] transaction","detail":"{read_only:false; response_revision:32984; number_of_response:1; }","duration":"123.62292ms","start":"2026-10-15T15:24:35.285202Z","end":"2026-10-15T15:24:35.408825Z","steps":["trace[1180713501] 'process raft request' (duration: 123.370874ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:24:35.408993Z","caller":"traceutil/trace.go:171","msg":"trace[44691905] transaction","detail":"{read_only:false; response_revision:32985; number_of_response:1; }","duration":"123.091908ms","start":"2026-10-15T15:24:35.285891Z","end":"2026-10-15T15:24:35.408983Z","steps":["trace[44691905] 'process raft request' (duration: 122.708619ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:24:45.573592Z","caller":"traceutil/trace.go:171","msg":"trace[1341378866] linearizableReadLoop","detail":"{readStateIndex:34119; appliedIndex:34115; }","duration":"104.69111ms","start":"2026-10-15T15:24:45.468877Z","end":"2026-10-15T15:24:45.573568Z","steps":["trace[1341378866] 'read index received' (duration: 35.800052ms)","trace[1341378866] 'applied index is now lower than readState.Index' (duration: 68.889778ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T15:24:45.573876Z","caller":"traceutil/trace.go:171","msg":"trace[1880055668] transaction","detail":"{read_only:false; response_revision:33060; number_of_response:1; }","duration":"112.289591ms","start":"2026-10-15T15:24:45.46153Z","end":"2026-10-15T15:24:45.57382Z","steps":["trace[1880055668] 'process raft request' (duration: 111.994054ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:24:45.574032Z","caller":"traceutil/trace.go:171","msg":"trace[1752026872] transaction","detail":"{read_only:false; response_revision:33058; number_of_response:1; }","duration":"122.293919ms","start":"2026-10-15T15:24:45.451681Z","end":"2026-10-15T15:24:45.573975Z","steps":["trace[1752026872] 'process raft request' (duration: 103.483012ms)","trace[1752026872] 'compare' (duration: 18.150041ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T15:24:45.574062Z","caller":"traceutil/trace.go:171","msg":"trace[1531038551] transaction","detail":"{read_only:false; response_revision:33059; number_of_response:1; }","duration":"114.881952ms","start":"2026-10-15T15:24:45.459148Z","end":"2026-10-15T15:24:45.57403Z","steps":["trace[1531038551] 'process raft request' (duration: 114.331249ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T15:24:45.574246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.365576ms","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-15T15:24:45.574287Z","caller":"traceutil/trace.go:171","msg":"trace[241320552] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:33060; }","duration":"105.457318ms","start":"2026-10-15T15:24:45.468818Z","end":"2026-10-15T15:24:45.574275Z","steps":["trace[241320552] 'agreement among raft nodes before linearized reading' (duration: 105.368286ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:24:47.698268Z","caller":"traceutil/trace.go:171","msg":"trace[1946826756] transaction","detail":"{read_only:false; response_revision:33075; number_of_response:1; }","duration":"105.135461ms","start":"2026-10-15T15:24:47.593117Z","end":"2026-10-15T15:24:47.698253Z","steps":["trace[1946826756] 'process raft request' (duration: 104.832804ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:24:47.698559Z","caller":"traceutil/trace.go:171","msg":"trace[547747867] transaction","detail":"{read_only:false; response_revision:33076; number_of_response:1; }","duration":"104.23839ms","start":"2026-10-15T15:24:47.594296Z","end":"2026-10-15T15:24:47.698535Z","steps":["trace[547747867] 'process raft request' (duration: 103.742198ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:24:57.530041Z","caller":"traceutil/trace.go:171","msg":"trace[245609256] transaction","detail":"{read_only:false; response_revision:33144; number_of_response:1; }","duration":"136.343764ms","start":"2026-10-15T15:24:57.393678Z","end":"2026-10-15T15:24:57.530022Z","steps":["trace[245609256] 'process raft request' (duration: 136.085058ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:24:57.971911Z","caller":"traceutil/trace.go:171","msg":"trace[1208104750] transaction","detail":"{read_only:false; response_revision:33151; number_of_response:1; }","duration":"112.25098ms","start":"2026-10-15T15:24:57.859627Z","end":"2026-10-15T15:24:57.971878Z","steps":["trace[1208104750] 'process raft request' (duration: 73.681543ms)","trace[1208104750] 'compare' (duration: 37.883441ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T15:24:57.971951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.213769ms","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-15T15:24:57.972011Z","caller":"traceutil/trace.go:171","msg":"trace[1604171962] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:33152; }","duration":"112.305891ms","start":"2026-10-15T15:24:57.85969Z","end":"2026-10-15T15:24:57.971996Z","steps":["trace[1604171962] 'agreement among raft nodes before linearized reading' (duration: 112.080876ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:25:02.674074Z","caller":"traceutil/trace.go:171","msg":"trace[1847264815] transaction","detail":"{read_only:false; response_revision:33203; number_of_response:1; }","duration":"132.787118ms","start":"2026-10-15T15:25:02.541253Z","end":"2026-10-15T15:25:02.67404Z","steps":["trace[1847264815] 'process raft request' (duration: 132.678315ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:25:02.674067Z","caller":"traceutil/trace.go:171","msg":"trace[1410895262] transaction","detail":"{read_only:false; response_revision:33202; number_of_response:1; }","duration":"173.992438ms","start":"2026-10-15T15:25:02.500037Z","end":"2026-10-15T15:25:02.67403Z","steps":["trace[1410895262] 'process raft request' (duration: 170.560626ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:28:43.100248Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32609} {"level":"info","ts":"2026-10-15T15:28:43.265701Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32609,"took":"160.375654ms","hash":4231166608,"current-db-size-bytes":57962496,"current-db-size":"58 MB","current-db-size-in-use-bytes":30224384,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-15T15:28:43.265993Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4231166608,"revision":32609,"compact-revision":30348} {"level":"info","ts":"2026-10-15T15:29:11.75255Z","caller":"traceutil/trace.go:171","msg":"trace[272122351] transaction","detail":"{read_only:false; response_revision:35038; number_of_response:1; }","duration":"104.787777ms","start":"2026-10-15T15:29:11.647728Z","end":"2026-10-15T15:29:11.752516Z","steps":["trace[272122351] 'process raft request' (duration: 104.48485ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T15:31:52.571679Z","caller":"traceutil/trace.go:171","msg":"trace[1837526364] transaction","detail":"{read_only:false; response_revision:36309; number_of_response:1; }","duration":"110.856106ms","start":"2026-10-15T15:31:52.460782Z","end":"2026-10-15T15:31:52.571638Z","steps":["trace[1837526364] 'process raft request' (duration: 56.263392ms)","trace[1837526364] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; req_size:532; } (duration: 54.251566ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T15:33:43.108031Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34830} {"level":"info","ts":"2026-10-15T15:33:43.257166Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34830,"took":"144.869901ms","hash":3359958683,"current-db-size-bytes":59273216,"current-db-size":"59 MB","current-db-size-in-use-bytes":31592448,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-15T15:33:43.257214Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3359958683,"revision":34830,"compact-revision":32609} {"level":"info","ts":"2026-10-15T15:37:18.024087Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c5298098e2dc0f92","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-15T15:37:18.029134Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-15T15:37:18.029319Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-15T15:38:43.11873Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37125} {"level":"info","ts":"2026-10-15T15:38:43.267646Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37125,"took":"143.882321ms","hash":3029686936,"current-db-size-bytes":60977152,"current-db-size":"61 MB","current-db-size-in-use-bytes":32653312,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-15T15:38:43.267725Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3029686936,"revision":37125,"compact-revision":34830} {"level":"info","ts":"2026-10-15T15:43:43.125762Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39405} {"level":"info","ts":"2026-10-15T15:43:43.27212Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39405,"took":"141.658447ms","hash":3464838066,"current-db-size-bytes":60977152,"current-db-size":"61 MB","current-db-size-in-use-bytes":31141888,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-15T15:43:43.272193Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3464838066,"revision":39405,"compact-revision":37125}