{"level":"warn","ts":"2026-07-16T06:49:07.243073Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-16T06:49:07.243178Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.89:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.89:2380","--initial-cluster=instance=https://199.204.45.89:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.89:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.89: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-07-16T06:49:07.24325Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-16T06:49:07.243262Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-07-16T06:49:07.243278Z","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-07-16T06:49:07.2439Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"]} {"level":"info","ts":"2026-07-16T06:49:07.243975Z","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://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.89: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-07-16T06:49:07.247613Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.437884ms"} {"level":"info","ts":"2026-07-16T06:49:07.260812Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c3b8446219deb8c1","cluster-id":"fe02a46d8aa9751f"} {"level":"info","ts":"2026-07-16T06:49:07.260933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=()"} {"level":"info","ts":"2026-07-16T06:49:07.26096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 0"} {"level":"info","ts":"2026-07-16T06:49:07.260977Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c3b8446219deb8c1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-16T06:49:07.260989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 1"} {"level":"info","ts":"2026-07-16T06:49:07.261049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"warn","ts":"2026-07-16T06:49:07.267508Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-16T06:49:07.269692Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-16T06:49:07.271609Z","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-07-16T06:49:07.275625Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c3b8446219deb8c1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-16T06:49:07.275768Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c3b8446219deb8c1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-16T06:49:07.275832Z","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-07-16T06:49:07.275952Z","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-07-16T06:49:07.275973Z","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-07-16T06:49:07.276972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"info","ts":"2026-07-16T06:49:07.277134Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","added-peer-id":"c3b8446219deb8c1","added-peer-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-07-16T06:49:07.279291Z","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-07-16T06:49:07.279502Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-07-16T06:49:07.279566Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-07-16T06:49:07.280623Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c3b8446219deb8c1","initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-16T06:49:07.280678Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-16T06:49:08.062317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 is starting a new election at term 1"} {"level":"info","ts":"2026-07-16T06:49:08.062378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-16T06:49:08.062415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgPreVoteResp from c3b8446219deb8c1 at term 1"} {"level":"info","ts":"2026-07-16T06:49:08.062433Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became candidate at term 2"} {"level":"info","ts":"2026-07-16T06:49:08.062452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgVoteResp from c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-07-16T06:49:08.062467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became leader at term 2"} {"level":"info","ts":"2026-07-16T06:49:08.062479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c3b8446219deb8c1 elected leader c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-07-16T06:49:08.063559Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c3b8446219deb8c1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.89:2379]}","request-path":"/0/members/c3b8446219deb8c1/attributes","cluster-id":"fe02a46d8aa9751f","publish-timeout":"7s"} {"level":"info","ts":"2026-07-16T06:49:08.06361Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-16T06:49:08.064031Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T06:49:08.064866Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-16T06:49:08.066018Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T06:49:08.066137Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T06:49:08.066042Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-16T06:49:08.066162Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-16T06:49:08.066171Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T06:49:08.070367Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-16T06:49:08.070942Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.89:2379"} {"level":"info","ts":"2026-07-16T06:49:22.242283Z","caller":"traceutil/trace.go:171","msg":"trace[1056191558] linearizableReadLoop","detail":"{readStateIndex:371; appliedIndex:370; }","duration":"161.671626ms","start":"2026-07-16T06:49:22.080583Z","end":"2026-07-16T06:49:22.242255Z","steps":["trace[1056191558] 'read index received' (duration: 161.500102ms)","trace[1056191558] 'applied index is now lower than readState.Index' (duration: 170.554µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:49:22.242414Z","caller":"traceutil/trace.go:171","msg":"trace[1990531400] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"271.190635ms","start":"2026-07-16T06:49:21.971214Z","end":"2026-07-16T06:49:22.242405Z","steps":["trace[1990531400] 'process raft request' (duration: 270.88291ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:49:22.242612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.984571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-16T06:49:22.242719Z","caller":"traceutil/trace.go:171","msg":"trace[886102867] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:359; }","duration":"162.180365ms","start":"2026-07-16T06:49:22.080523Z","end":"2026-07-16T06:49:22.242704Z","steps":["trace[886102867] 'agreement among raft nodes before linearized reading' (duration: 161.991662ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:49:22.242825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.735942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4322"} {"level":"info","ts":"2026-07-16T06:49:22.242908Z","caller":"traceutil/trace.go:171","msg":"trace[418599961] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:359; }","duration":"123.874364ms","start":"2026-07-16T06:49:22.119015Z","end":"2026-07-16T06:49:22.242889Z","steps":["trace[418599961] 'agreement among raft nodes before linearized reading' (duration: 123.69474ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:49:44.77958Z","caller":"traceutil/trace.go:171","msg":"trace[1929333655] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"140.119804ms","start":"2026-07-16T06:49:44.639428Z","end":"2026-07-16T06:49:44.779548Z","steps":["trace[1929333655] 'process raft request' (duration: 139.89259ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:49:44.831811Z","caller":"traceutil/trace.go:171","msg":"trace[1207286719] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"112.387635ms","start":"2026-07-16T06:49:44.719382Z","end":"2026-07-16T06:49:44.831769Z","steps":["trace[1207286719] 'process raft request' (duration: 112.052509ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:49:44.831828Z","caller":"traceutil/trace.go:171","msg":"trace[887945727] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"106.788498ms","start":"2026-07-16T06:49:44.725013Z","end":"2026-07-16T06:49:44.831801Z","steps":["trace[887945727] 'process raft request' (duration: 106.608524ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:49:44.832313Z","caller":"traceutil/trace.go:171","msg":"trace[168366576] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"106.876949ms","start":"2026-07-16T06:49:44.725042Z","end":"2026-07-16T06:49:44.831919Z","steps":["trace[168366576] 'process raft request' (duration: 106.640794ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:49:51.967001Z","caller":"traceutil/trace.go:171","msg":"trace[2069803368] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"421.991174ms","start":"2026-07-16T06:49:51.544979Z","end":"2026-07-16T06:49:51.96697Z","steps":["trace[2069803368] 'process raft request' (duration: 403.41026ms)","trace[2069803368] 'compare' (duration: 18.392681ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:49:51.967566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:49:51.544937Z","time spent":"422.159437ms","remote":"127.0.0.1:49712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-16T06:49:53.308789Z","caller":"traceutil/trace.go:171","msg":"trace[221908513] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"104.716938ms","start":"2026-07-16T06:49:53.204038Z","end":"2026-07-16T06:49:53.308755Z","steps":["trace[221908513] 'process raft request' (duration: 99.165172ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:51:22.702198Z","caller":"traceutil/trace.go:171","msg":"trace[1675004001] linearizableReadLoop","detail":"{readStateIndex:1899; appliedIndex:1898; }","duration":"224.408773ms","start":"2026-07-16T06:51:22.477755Z","end":"2026-07-16T06:51:22.702163Z","steps":["trace[1675004001] 'read index received' (duration: 224.133257ms)","trace[1675004001] 'applied index is now lower than readState.Index' (duration: 274.556µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:51:22.702325Z","caller":"traceutil/trace.go:171","msg":"trace[106894318] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"258.594266ms","start":"2026-07-16T06:51:22.443669Z","end":"2026-07-16T06:51:22.702263Z","steps":["trace[106894318] 'process raft request' (duration: 258.32662ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:51:22.702446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.277653ms","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":"warn","ts":"2026-07-16T06:51:22.702461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.686669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-58921b5a-fb73-471d-b787-d5645cb7aa1d\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-07-16T06:51:22.702536Z","caller":"traceutil/trace.go:171","msg":"trace[1759682680] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1830; }","duration":"205.370335ms","start":"2026-07-16T06:51:22.497111Z","end":"2026-07-16T06:51:22.702482Z","steps":["trace[1759682680] 'agreement among raft nodes before linearized reading' (duration: 205.200491ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:51:22.702548Z","caller":"traceutil/trace.go:171","msg":"trace[1191103165] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-58921b5a-fb73-471d-b787-d5645cb7aa1d; range_end:; response_count:1; response_revision:1830; }","duration":"224.825442ms","start":"2026-07-16T06:51:22.477707Z","end":"2026-07-16T06:51:22.702532Z","steps":["trace[1191103165] 'agreement among raft nodes before linearized reading' (duration: 224.585187ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:51:23.191957Z","caller":"traceutil/trace.go:171","msg":"trace[752813241] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"344.413187ms","start":"2026-07-16T06:51:22.847509Z","end":"2026-07-16T06:51:23.191922Z","steps":["trace[752813241] 'process raft request' (duration: 343.525088ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:51:23.192403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:51:22.847493Z","time spent":"344.558951ms","remote":"127.0.0.1:49542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T06:51:23.19558Z","caller":"traceutil/trace.go:171","msg":"trace[1960612654] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"347.161767ms","start":"2026-07-16T06:51:22.848395Z","end":"2026-07-16T06:51:23.195557Z","steps":["trace[1960612654] 'process raft request' (duration: 346.997523ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:51:23.19573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:51:22.848368Z","time spent":"347.276008ms","remote":"127.0.0.1:49542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T06:51:23.196071Z","caller":"traceutil/trace.go:171","msg":"trace[798397455] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"347.484543ms","start":"2026-07-16T06:51:22.848554Z","end":"2026-07-16T06:51:23.196039Z","steps":["trace[798397455] 'process raft request' (duration: 346.955902ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:51:23.196141Z","caller":"traceutil/trace.go:171","msg":"trace[1034508226] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"347.515363ms","start":"2026-07-16T06:51:22.848592Z","end":"2026-07-16T06:51:23.196107Z","steps":["trace[1034508226] 'process raft request' (duration: 347.296189ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:51:23.196322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:51:22.848544Z","time spent":"347.676527ms","remote":"127.0.0.1:49662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T06:51:23.196408Z","caller":"traceutil/trace.go:171","msg":"trace[1154300811] linearizableReadLoop","detail":"{readStateIndex:1905; appliedIndex:1901; }","duration":"191.253273ms","start":"2026-07-16T06:51:23.005125Z","end":"2026-07-16T06:51:23.196378Z","steps":["trace[1154300811] 'read index received' (duration: 185.911138ms)","trace[1154300811] 'applied index is now lower than readState.Index' (duration: 5.340545ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:51:23.196586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.992907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T06:51:23.196624Z","caller":"traceutil/trace.go:171","msg":"trace[961666937] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1838; }","duration":"191.061219ms","start":"2026-07-16T06:51:23.005555Z","end":"2026-07-16T06:51:23.196616Z","steps":["trace[961666937] 'agreement among raft nodes before linearized reading' (duration: 191.006388ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:51:23.196694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.546369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-16T06:51:23.196729Z","caller":"traceutil/trace.go:171","msg":"trace[1779437308] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1838; }","duration":"191.650981ms","start":"2026-07-16T06:51:23.005069Z","end":"2026-07-16T06:51:23.19672Z","steps":["trace[1779437308] 'agreement among raft nodes before linearized reading' (duration: 191.462277ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:51:23.196805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.141261ms","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-07-16T06:51:23.196833Z","caller":"traceutil/trace.go:171","msg":"trace[1832629193] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1838; }","duration":"191.209372ms","start":"2026-07-16T06:51:23.005618Z","end":"2026-07-16T06:51:23.196827Z","steps":["trace[1832629193] 'agreement among raft nodes before linearized reading' (duration: 191.08653ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:51:23.197167Z","caller":"traceutil/trace.go:171","msg":"trace[1084769676] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"159.807597ms","start":"2026-07-16T06:51:23.037161Z","end":"2026-07-16T06:51:23.196968Z","steps":["trace[1084769676] 'process raft request' (duration: 158.867967ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:51:23.197561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:51:22.848576Z","time spent":"347.785221ms","remote":"127.0.0.1:49662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T06:51:34.042146Z","caller":"traceutil/trace.go:171","msg":"trace[1850767893] transaction","detail":"{read_only:false; response_revision:1934; number_of_response:1; }","duration":"135.402574ms","start":"2026-07-16T06:51:33.906689Z","end":"2026-07-16T06:51:34.042092Z","steps":["trace[1850767893] 'process raft request' (duration: 133.525683ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:52:13.337364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.701134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T06:52:13.337522Z","caller":"traceutil/trace.go:171","msg":"trace[1201123305] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:2156; }","duration":"179.906039ms","start":"2026-07-16T06:52:13.157591Z","end":"2026-07-16T06:52:13.337497Z","steps":["trace[1201123305] 'count revisions from in-memory index tree' (duration: 179.610723ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:52:13.750037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.811815ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T06:52:13.750151Z","caller":"traceutil/trace.go:171","msg":"trace[630639266] linearizableReadLoop","detail":"{readStateIndex:2238; appliedIndex:2237; }","duration":"291.531273ms","start":"2026-07-16T06:52:13.458603Z","end":"2026-07-16T06:52:13.750134Z","steps":["trace[630639266] 'read index received' (duration: 43.391101ms)","trace[630639266] 'applied index is now lower than readState.Index' (duration: 248.138802ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:52:13.750216Z","caller":"traceutil/trace.go:171","msg":"trace[1329680486] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"303.149093ms","start":"2026-07-16T06:52:13.44702Z","end":"2026-07-16T06:52:13.750169Z","steps":["trace[1329680486] 'process raft request' (duration: 54.916028ms)","trace[1329680486] 'compare' (duration: 247.634681ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:52:13.750397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:52:13.44698Z","time spent":"303.322267ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T06:52:13.750423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.804409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-16T06:52:13.750519Z","caller":"traceutil/trace.go:171","msg":"trace[1804630459] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2158; }","duration":"291.952122ms","start":"2026-07-16T06:52:13.458546Z","end":"2026-07-16T06:52:13.750498Z","steps":["trace[1804630459] 'agreement among raft nodes before linearized reading' (duration: 291.634195ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:52:14.208367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.240227ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T06:52:14.208482Z","caller":"traceutil/trace.go:171","msg":"trace[1199644278] linearizableReadLoop","detail":"{readStateIndex:2239; appliedIndex:2238; }","duration":"458.281869ms","start":"2026-07-16T06:52:13.750178Z","end":"2026-07-16T06:52:14.208459Z","steps":["trace[1199644278] 'read index received' (duration: 145.853618ms)","trace[1199644278] 'applied index is now lower than readState.Index' (duration: 312.426831ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:52:14.208705Z","caller":"traceutil/trace.go:171","msg":"trace[1244712332] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"513.169837ms","start":"2026-07-16T06:52:13.695495Z","end":"2026-07-16T06:52:14.208665Z","steps":["trace[1244712332] 'process raft request' (duration: 200.539482ms)","trace[1244712332] 'compare' (duration: 312.042102ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:52:14.208908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:52:13.695468Z","time spent":"513.31942ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T06:52:14.208907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.84368ms","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-07-16T06:52:14.20898Z","caller":"traceutil/trace.go:171","msg":"trace[1535488181] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2159; }","duration":"470.965872ms","start":"2026-07-16T06:52:13.738002Z","end":"2026-07-16T06:52:14.208968Z","steps":["trace[1535488181] 'agreement among raft nodes before linearized reading' (duration: 470.669926ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:52:14.209071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:52:13.737975Z","time spent":"471.082984ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-16T06:52:14.209671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.844506ms","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-07-16T06:52:14.209735Z","caller":"traceutil/trace.go:171","msg":"trace[1023800504] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2159; }","duration":"743.944688ms","start":"2026-07-16T06:52:13.465776Z","end":"2026-07-16T06:52:14.209721Z","steps":["trace[1023800504] 'agreement among raft nodes before linearized reading' (duration: 743.758764ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:52:14.209763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:52:13.465758Z","time spent":"743.999269ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-16T06:52:14.265775Z","caller":"traceutil/trace.go:171","msg":"trace[1872387590] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"510.857818ms","start":"2026-07-16T06:52:13.75489Z","end":"2026-07-16T06:52:14.265748Z","steps":["trace[1872387590] 'process raft request' (duration: 510.723575ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:52:14.265956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:52:13.754864Z","time spent":"510.984031ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T06:52:14.271582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.225758ms","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-07-16T06:52:14.271654Z","caller":"traceutil/trace.go:171","msg":"trace[1926438521] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2164; }","duration":"409.373051ms","start":"2026-07-16T06:52:13.862269Z","end":"2026-07-16T06:52:14.271642Z","steps":["trace[1926438521] 'agreement among raft nodes before linearized reading' (duration: 409.255289ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:52:14.271657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.932916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-07-16T06:52:14.271707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:52:13.862247Z","time spent":"409.434712ms","remote":"127.0.0.1:35898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-07-16T06:52:14.27171Z","caller":"traceutil/trace.go:171","msg":"trace[887536840] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2164; }","duration":"157.042338ms","start":"2026-07-16T06:52:14.114649Z","end":"2026-07-16T06:52:14.271691Z","steps":["trace[887536840] 'agreement among raft nodes before linearized reading' (duration: 156.886395ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:52:14.271791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.605647ms","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-07-16T06:52:14.27184Z","caller":"traceutil/trace.go:171","msg":"trace[1162246273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2164; }","duration":"189.696639ms","start":"2026-07-16T06:52:14.082133Z","end":"2026-07-16T06:52:14.27183Z","steps":["trace[1162246273] 'agreement among raft nodes before linearized reading' (duration: 189.584247ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:52:14.271873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.105251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T06:52:14.271519Z","caller":"traceutil/trace.go:171","msg":"trace[1969908384] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"306.192659ms","start":"2026-07-16T06:52:13.9653Z","end":"2026-07-16T06:52:14.271492Z","steps":["trace[1969908384] 'process raft request' (duration: 306.024685ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:52:14.271927Z","caller":"traceutil/trace.go:171","msg":"trace[1296538959] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2164; }","duration":"268.196333ms","start":"2026-07-16T06:52:14.003714Z","end":"2026-07-16T06:52:14.27191Z","steps":["trace[1296538959] 'agreement among raft nodes before linearized reading' (duration: 268.07996ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:52:14.271946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.339588ms","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-07-16T06:52:14.271994Z","caller":"traceutil/trace.go:171","msg":"trace[951358238] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2164; }","duration":"173.383169ms","start":"2026-07-16T06:52:14.098593Z","end":"2026-07-16T06:52:14.271977Z","steps":["trace[951358238] 'agreement among raft nodes before linearized reading' (duration: 173.263627ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:52:14.272017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:52:13.965273Z","time spent":"306.661088ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T06:52:14.61599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.522675ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T06:52:14.616103Z","caller":"traceutil/trace.go:171","msg":"trace[2068040815] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"340.159117ms","start":"2026-07-16T06:52:14.275923Z","end":"2026-07-16T06:52:14.616082Z","steps":["trace[2068040815] 'process raft request' (duration: 171.452739ms)","trace[2068040815] 'compare' (duration: 168.31706ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:52:14.616162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:52:14.275911Z","time spent":"340.222888ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T06:52:14.619236Z","caller":"traceutil/trace.go:171","msg":"trace[239121401] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"342.177979ms","start":"2026-07-16T06:52:14.277039Z","end":"2026-07-16T06:52:14.619217Z","steps":["trace[239121401] 'process raft request' (duration: 342.082547ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:52:14.61933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:52:14.27703Z","time spent":"342.257181ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T06:53:01.191236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.975608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T06:53:01.191479Z","caller":"traceutil/trace.go:171","msg":"trace[804346456] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2590; }","duration":"184.320865ms","start":"2026-07-16T06:53:01.007132Z","end":"2026-07-16T06:53:01.191452Z","steps":["trace[804346456] 'range keys from in-memory index tree' (duration: 183.864656ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:55:49.160837Z","caller":"traceutil/trace.go:171","msg":"trace[823602399] linearizableReadLoop","detail":"{readStateIndex:3830; appliedIndex:3829; }","duration":"118.052ms","start":"2026-07-16T06:55:49.042754Z","end":"2026-07-16T06:55:49.160806Z","steps":["trace[823602399] 'read index received' (duration: 42.604695ms)","trace[823602399] 'applied index is now lower than readState.Index' (duration: 75.445785ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:55:49.160867Z","caller":"traceutil/trace.go:171","msg":"trace[639827009] transaction","detail":"{read_only:false; response_revision:3692; number_of_response:1; }","duration":"205.463385ms","start":"2026-07-16T06:55:48.955377Z","end":"2026-07-16T06:55:49.16084Z","steps":["trace[639827009] 'process raft request' (duration: 129.907138ms)","trace[639827009] 'compare' (duration: 75.216959ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:55:49.161028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.267235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1633"} {"level":"info","ts":"2026-07-16T06:55:49.161054Z","caller":"traceutil/trace.go:171","msg":"trace[735553282] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:3692; }","duration":"118.349617ms","start":"2026-07-16T06:55:49.042695Z","end":"2026-07-16T06:55:49.161045Z","steps":["trace[735553282] 'agreement among raft nodes before linearized reading' (duration: 118.210954ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:56:11.413106Z","caller":"traceutil/trace.go:171","msg":"trace[1429827019] transaction","detail":"{read_only:false; response_revision:3813; number_of_response:1; }","duration":"109.868225ms","start":"2026-07-16T06:56:11.303199Z","end":"2026-07-16T06:56:11.413067Z","steps":["trace[1429827019] 'process raft request' (duration: 109.755093ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:57:37.107559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.255712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:413130"} {"level":"info","ts":"2026-07-16T06:57:37.107693Z","caller":"traceutil/trace.go:171","msg":"trace[187853563] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:4880; }","duration":"164.443817ms","start":"2026-07-16T06:57:36.943222Z","end":"2026-07-16T06:57:37.107666Z","steps":["trace[187853563] 'range keys from in-memory index tree' (duration: 163.801393ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:57:37.476027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.82161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T06:57:37.47616Z","caller":"traceutil/trace.go:171","msg":"trace[873544412] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:4881; }","duration":"115.034724ms","start":"2026-07-16T06:57:37.361099Z","end":"2026-07-16T06:57:37.476134Z","steps":["trace[873544412] 'count revisions from in-memory index tree' (duration: 114.696138ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:57:37.679934Z","caller":"traceutil/trace.go:171","msg":"trace[1810573496] linearizableReadLoop","detail":"{readStateIndex:5067; appliedIndex:5066; }","duration":"111.896151ms","start":"2026-07-16T06:57:37.568011Z","end":"2026-07-16T06:57:37.679907Z","steps":["trace[1810573496] 'read index received' (duration: 110.464233ms)","trace[1810573496] 'applied index is now lower than readState.Index' (duration: 1.430678ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:57:37.679975Z","caller":"traceutil/trace.go:171","msg":"trace[70479969] transaction","detail":"{read_only:false; response_revision:4883; number_of_response:1; }","duration":"126.339737ms","start":"2026-07-16T06:57:37.553599Z","end":"2026-07-16T06:57:37.679938Z","steps":["trace[70479969] 'process raft request' (duration: 124.902439ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:57:37.680154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.127147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-7pvtl\" ","response":"range_response_count:1 size:9753"} {"level":"info","ts":"2026-07-16T06:57:37.680243Z","caller":"traceutil/trace.go:171","msg":"trace[1039435450] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-7pvtl; range_end:; response_count:1; response_revision:4883; }","duration":"112.279699ms","start":"2026-07-16T06:57:37.567948Z","end":"2026-07-16T06:57:37.680227Z","steps":["trace[1039435450] 'agreement among raft nodes before linearized reading' (duration: 112.060165ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:57:40.551716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.762262ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-16T06:57:40.551904Z","caller":"traceutil/trace.go:171","msg":"trace[532045695] transaction","detail":"{read_only:false; response_revision:5011; number_of_response:1; }","duration":"303.927122ms","start":"2026-07-16T06:57:40.247949Z","end":"2026-07-16T06:57:40.551876Z","steps":["trace[532045695] 'process raft request' (duration: 45.869794ms)","trace[532045695] 'compare' (duration: 257.386324ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:57:40.552017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:57:40.247933Z","time spent":"304.047634ms","remote":"127.0.0.1:49564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4888,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-16T06:57:40.636573Z","caller":"traceutil/trace.go:171","msg":"trace[2081034675] linearizableReadLoop","detail":"{readStateIndex:5200; appliedIndex:5199; }","duration":"233.769081ms","start":"2026-07-16T06:57:40.40278Z","end":"2026-07-16T06:57:40.636549Z","steps":["trace[2081034675] 'read index received' (duration: 233.72341ms)","trace[2081034675] 'applied index is now lower than readState.Index' (duration: 44.801µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:57:40.63668Z","caller":"traceutil/trace.go:171","msg":"trace[181203357] transaction","detail":"{read_only:false; response_revision:5012; number_of_response:1; }","duration":"381.432116ms","start":"2026-07-16T06:57:40.255212Z","end":"2026-07-16T06:57:40.636644Z","steps":["trace[181203357] 'process raft request' (duration: 381.190621ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:57:40.636824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.033236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-91c0f634-e2bd-4718-b2fb-9aad6c6dada2\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-07-16T06:57:40.636854Z","caller":"traceutil/trace.go:171","msg":"trace[1890646155] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-91c0f634-e2bd-4718-b2fb-9aad6c6dada2; range_end:; response_count:1; response_revision:5012; }","duration":"234.130388ms","start":"2026-07-16T06:57:40.402715Z","end":"2026-07-16T06:57:40.636845Z","steps":["trace[1890646155] 'agreement among raft nodes before linearized reading' (duration: 233.950604ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:57:40.636895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:57:40.255169Z","time spent":"381.60883ms","remote":"127.0.0.1:49472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58177,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T06:57:40.692509Z","caller":"traceutil/trace.go:171","msg":"trace[1037522414] transaction","detail":"{read_only:false; response_revision:5013; number_of_response:1; }","duration":"136.368874ms","start":"2026-07-16T06:57:40.556108Z","end":"2026-07-16T06:57:40.692477Z","steps":["trace[1037522414] 'process raft request' (duration: 108.368763ms)","trace[1037522414] 'compare' (duration: 27.744056ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:57:40.692842Z","caller":"traceutil/trace.go:171","msg":"trace[44787389] transaction","detail":"{read_only:false; response_revision:5014; number_of_response:1; }","duration":"136.001986ms","start":"2026-07-16T06:57:40.556818Z","end":"2026-07-16T06:57:40.69282Z","steps":["trace[44787389] 'process raft request' (duration: 135.602579ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:57:40.693223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.037117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-07-16T06:57:40.693248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.228343ms","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-07-16T06:57:40.693321Z","caller":"traceutil/trace.go:171","msg":"trace[771155942] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5015; }","duration":"230.138939ms","start":"2026-07-16T06:57:40.463129Z","end":"2026-07-16T06:57:40.693268Z","steps":["trace[771155942] 'agreement among raft nodes before linearized reading' (duration: 229.929765ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:57:40.693196Z","caller":"traceutil/trace.go:171","msg":"trace[1783525104] transaction","detail":"{read_only:false; response_revision:5015; number_of_response:1; }","duration":"133.787643ms","start":"2026-07-16T06:57:40.559371Z","end":"2026-07-16T06:57:40.693158Z","steps":["trace[1783525104] 'process raft request' (duration: 133.298463ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:57:40.693336Z","caller":"traceutil/trace.go:171","msg":"trace[293846646] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5015; }","duration":"255.370375ms","start":"2026-07-16T06:57:40.437952Z","end":"2026-07-16T06:57:40.693322Z","steps":["trace[293846646] 'agreement among raft nodes before linearized reading' (duration: 255.152341ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:57:42.87099Z","caller":"traceutil/trace.go:171","msg":"trace[1898585011] linearizableReadLoop","detail":"{readStateIndex:5236; appliedIndex:5232; }","duration":"105.133219ms","start":"2026-07-16T06:57:42.765829Z","end":"2026-07-16T06:57:42.870963Z","steps":["trace[1898585011] 'read index received' (duration: 79.519024ms)","trace[1898585011] 'applied index is now lower than readState.Index' (duration: 25.612905ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:57:42.87113Z","caller":"traceutil/trace.go:171","msg":"trace[1695200536] transaction","detail":"{read_only:false; response_revision:5044; number_of_response:1; }","duration":"109.414284ms","start":"2026-07-16T06:57:42.761706Z","end":"2026-07-16T06:57:42.871121Z","steps":["trace[1695200536] 'process raft request' (duration: 109.104727ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:57:42.871298Z","caller":"traceutil/trace.go:171","msg":"trace[333949140] transaction","detail":"{read_only:false; response_revision:5043; number_of_response:1; }","duration":"109.69498ms","start":"2026-07-16T06:57:42.761557Z","end":"2026-07-16T06:57:42.871252Z","steps":["trace[333949140] 'process raft request' (duration: 83.769919ms)","trace[333949140] 'compare' (duration: 25.290838ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:57:42.871422Z","caller":"traceutil/trace.go:171","msg":"trace[1393316326] transaction","detail":"{read_only:false; response_revision:5046; number_of_response:1; }","duration":"109.300432ms","start":"2026-07-16T06:57:42.762084Z","end":"2026-07-16T06:57:42.871384Z","steps":["trace[1393316326] 'process raft request' (duration: 108.839963ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:57:42.871562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.70651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-16T06:57:42.871597Z","caller":"traceutil/trace.go:171","msg":"trace[1819962850] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5046; }","duration":"105.803923ms","start":"2026-07-16T06:57:42.765782Z","end":"2026-07-16T06:57:42.871586Z","steps":["trace[1819962850] 'agreement among raft nodes before linearized reading' (duration: 105.637769ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:57:42.871658Z","caller":"traceutil/trace.go:171","msg":"trace[872201332] transaction","detail":"{read_only:false; response_revision:5045; number_of_response:1; }","duration":"109.586387ms","start":"2026-07-16T06:57:42.762023Z","end":"2026-07-16T06:57:42.87161Z","steps":["trace[872201332] 'process raft request' (duration: 108.867142ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:57:43.004819Z","caller":"traceutil/trace.go:171","msg":"trace[376180907] transaction","detail":"{read_only:false; response_revision:5047; number_of_response:1; }","duration":"136.892594ms","start":"2026-07-16T06:57:42.867889Z","end":"2026-07-16T06:57:43.004781Z","steps":["trace[376180907] 'process raft request' (duration: 106.253261ms)","trace[376180907] 'compare' (duration: 30.421119ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:57:43.004892Z","caller":"traceutil/trace.go:171","msg":"trace[1301038797] linearizableReadLoop","detail":"{readStateIndex:5237; appliedIndex:5236; }","duration":"133.790542ms","start":"2026-07-16T06:57:42.871069Z","end":"2026-07-16T06:57:43.004859Z","steps":["trace[1301038797] 'read index received' (duration: 103.093937ms)","trace[1301038797] 'applied index is now lower than readState.Index' (duration: 30.692935ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:57:43.005185Z","caller":"traceutil/trace.go:171","msg":"trace[803657393] transaction","detail":"{read_only:false; response_revision:5048; number_of_response:1; }","duration":"129.413736ms","start":"2026-07-16T06:57:42.875731Z","end":"2026-07-16T06:57:43.005145Z","steps":["trace[803657393] 'process raft request' (duration: 129.026889ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:57:43.005203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.709015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-d6kwj\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-07-16T06:57:43.005247Z","caller":"traceutil/trace.go:171","msg":"trace[1656957657] range","detail":"{range_begin:/registry/pods/openstack/keepalived-d6kwj; range_end:; response_count:1; response_revision:5048; }","duration":"153.829907ms","start":"2026-07-16T06:57:42.851406Z","end":"2026-07-16T06:57:43.005236Z","steps":["trace[1656957657] 'agreement among raft nodes before linearized reading' (duration: 153.604683ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:57:43.005284Z","caller":"traceutil/trace.go:171","msg":"trace[132877561] transaction","detail":"{read_only:false; response_revision:5049; number_of_response:1; }","duration":"128.299564ms","start":"2026-07-16T06:57:42.87696Z","end":"2026-07-16T06:57:43.00526Z","steps":["trace[132877561] 'process raft request' (duration: 128.09354ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:57:49.91562Z","caller":"traceutil/trace.go:171","msg":"trace[1962148019] transaction","detail":"{read_only:false; response_revision:5208; number_of_response:1; }","duration":"115.405926ms","start":"2026-07-16T06:57:49.800179Z","end":"2026-07-16T06:57:49.915585Z","steps":["trace[1962148019] 'process raft request' (duration: 104.030385ms)","trace[1962148019] 'compare' (duration: 11.221358ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:57:55.56299Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313097249751296807,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-16T06:57:55.567329Z","caller":"traceutil/trace.go:171","msg":"trace[1966718363] linearizableReadLoop","detail":"{readStateIndex:5483; appliedIndex:5479; }","duration":"504.571711ms","start":"2026-07-16T06:57:55.062726Z","end":"2026-07-16T06:57:55.567298Z","steps":["trace[1966718363] 'read index received' (duration: 501.353148ms)","trace[1966718363] 'applied index is now lower than readState.Index' (duration: 3.217313ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:57:55.567501Z","caller":"traceutil/trace.go:171","msg":"trace[896159809] transaction","detail":"{read_only:false; response_revision:5285; number_of_response:1; }","duration":"583.920845ms","start":"2026-07-16T06:57:54.983567Z","end":"2026-07-16T06:57:55.567488Z","steps":["trace[896159809] 'process raft request' (duration: 583.506998ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:57:55.567628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:57:54.983536Z","time spent":"583.999916ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T06:57:55.56765Z","caller":"traceutil/trace.go:171","msg":"trace[1349540364] transaction","detail":"{read_only:false; response_revision:5284; number_of_response:1; }","duration":"584.14871ms","start":"2026-07-16T06:57:54.983453Z","end":"2026-07-16T06:57:55.567601Z","steps":["trace[1349540364] 'process raft request' (duration: 580.609851ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:57:55.567699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.963788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-16T06:57:55.567782Z","caller":"traceutil/trace.go:171","msg":"trace[332349395] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5287; }","duration":"505.111951ms","start":"2026-07-16T06:57:55.062656Z","end":"2026-07-16T06:57:55.567768Z","steps":["trace[332349395] 'agreement among raft nodes before linearized reading' (duration: 504.908587ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:57:55.567822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:57:55.062628Z","time spent":"505.187692ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-16T06:57:55.567804Z","caller":"traceutil/trace.go:171","msg":"trace[1344148542] transaction","detail":"{read_only:false; response_revision:5287; number_of_response:1; }","duration":"231.064888ms","start":"2026-07-16T06:57:55.336692Z","end":"2026-07-16T06:57:55.567757Z","steps":["trace[1344148542] 'process raft request' (duration: 230.558558ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:57:55.567805Z","caller":"traceutil/trace.go:171","msg":"trace[1243905712] transaction","detail":"{read_only:false; response_revision:5286; number_of_response:1; }","duration":"516.890401ms","start":"2026-07-16T06:57:55.050863Z","end":"2026-07-16T06:57:55.567754Z","steps":["trace[1243905712] 'process raft request' (duration: 516.35041ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:57:55.56789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.632454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-d6kwj\" ","response":"range_response_count:1 size:6520"} {"level":"warn","ts":"2026-07-16T06:57:55.567899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:57:54.983437Z","time spent":"584.318233ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T06:57:55.567935Z","caller":"traceutil/trace.go:171","msg":"trace[1847676942] range","detail":"{range_begin:/registry/pods/openstack/keepalived-d6kwj; range_end:; response_count:1; response_revision:5287; }","duration":"500.724756ms","start":"2026-07-16T06:57:55.067197Z","end":"2026-07-16T06:57:55.567922Z","steps":["trace[1847676942] 'agreement among raft nodes before linearized reading' (duration: 500.569823ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:57:55.567979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:57:55.067172Z","time spent":"500.800668ms","remote":"127.0.0.1:49564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6544,"request content":"key:\"/registry/pods/openstack/keepalived-d6kwj\" "} {"level":"warn","ts":"2026-07-16T06:57:55.568031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:57:55.050836Z","time spent":"517.085445ms","remote":"127.0.0.1:49650","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-07-16T06:58:02.768328Z","caller":"traceutil/trace.go:171","msg":"trace[473038089] transaction","detail":"{read_only:false; response_revision:5475; number_of_response:1; }","duration":"106.083535ms","start":"2026-07-16T06:58:02.662198Z","end":"2026-07-16T06:58:02.768281Z","steps":["trace[473038089] 'process raft request' (duration: 105.81196ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:58:03.180856Z","caller":"traceutil/trace.go:171","msg":"trace[1375309471] transaction","detail":"{read_only:false; response_revision:5477; number_of_response:1; }","duration":"208.891236ms","start":"2026-07-16T06:58:02.971918Z","end":"2026-07-16T06:58:03.180809Z","steps":["trace[1375309471] 'process raft request' (duration: 171.932046ms)","trace[1375309471] 'compare' (duration: 36.531441ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:58:03.181013Z","caller":"traceutil/trace.go:171","msg":"trace[1870324388] linearizableReadLoop","detail":"{readStateIndex:5679; appliedIndex:5677; }","duration":"208.779024ms","start":"2026-07-16T06:58:02.972198Z","end":"2026-07-16T06:58:03.180977Z","steps":["trace[1870324388] 'read index received' (duration: 171.832134ms)","trace[1870324388] 'applied index is now lower than readState.Index' (duration: 36.94557ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:58:03.181167Z","caller":"traceutil/trace.go:171","msg":"trace[377941168] transaction","detail":"{read_only:false; response_revision:5478; number_of_response:1; }","duration":"209.033159ms","start":"2026-07-16T06:58:02.97212Z","end":"2026-07-16T06:58:03.181153Z","steps":["trace[377941168] 'process raft request' (duration: 208.589749ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:58:03.181359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.136831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-pushgateway-7b8659c68b-xql7v\" ","response":"range_response_count:1 size:4343"} {"level":"warn","ts":"2026-07-16T06:58:03.181367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.511756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T06:58:03.181416Z","caller":"traceutil/trace.go:171","msg":"trace[1964299300] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-pushgateway-7b8659c68b-xql7v; range_end:; response_count:1; response_revision:5478; }","duration":"209.244462ms","start":"2026-07-16T06:58:02.972155Z","end":"2026-07-16T06:58:03.1814Z","steps":["trace[1964299300] 'agreement among raft nodes before linearized reading' (duration: 209.050989ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:58:03.181466Z","caller":"traceutil/trace.go:171","msg":"trace[726045730] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5478; }","duration":"175.627208ms","start":"2026-07-16T06:58:03.005815Z","end":"2026-07-16T06:58:03.181442Z","steps":["trace[726045730] 'agreement among raft nodes before linearized reading' (duration: 175.464805ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:58:03.181566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.27978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-16T06:58:03.181648Z","caller":"traceutil/trace.go:171","msg":"trace[1408546932] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5478; }","duration":"141.451134ms","start":"2026-07-16T06:58:03.040186Z","end":"2026-07-16T06:58:03.181637Z","steps":["trace[1408546932] 'agreement among raft nodes before linearized reading' (duration: 141.116507ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:58:55.836614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.541673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/loki-0\" ","response":"range_response_count:1 size:6134"} {"level":"info","ts":"2026-07-16T06:58:55.836738Z","caller":"traceutil/trace.go:171","msg":"trace[2045104626] range","detail":"{range_begin:/registry/pods/monitoring/loki-0; range_end:; response_count:1; response_revision:5947; }","duration":"141.721056ms","start":"2026-07-16T06:58:55.694992Z","end":"2026-07-16T06:58:55.836713Z","steps":["trace[2045104626] 'range keys from in-memory index tree' (duration: 141.261067ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:58:56.037166Z","caller":"traceutil/trace.go:171","msg":"trace[593375384] transaction","detail":"{read_only:false; response_revision:5951; number_of_response:1; }","duration":"144.877486ms","start":"2026-07-16T06:58:55.892264Z","end":"2026-07-16T06:58:56.037141Z","steps":["trace[593375384] 'process raft request' (duration: 59.88545ms)","trace[593375384] 'compare' (duration: 84.798412ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:58:56.037459Z","caller":"traceutil/trace.go:171","msg":"trace[205662298] transaction","detail":"{read_only:false; response_revision:5952; number_of_response:1; }","duration":"144.913716ms","start":"2026-07-16T06:58:55.892508Z","end":"2026-07-16T06:58:56.037422Z","steps":["trace[205662298] 'process raft request' (duration: 144.5816ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:58:56.037577Z","caller":"traceutil/trace.go:171","msg":"trace[1262097727] transaction","detail":"{read_only:false; response_revision:5953; number_of_response:1; }","duration":"144.907847ms","start":"2026-07-16T06:58:55.892653Z","end":"2026-07-16T06:58:56.037561Z","steps":["trace[1262097727] 'process raft request' (duration: 144.674862ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:58:56.037604Z","caller":"traceutil/trace.go:171","msg":"trace[1037655411] transaction","detail":"{read_only:false; response_revision:5954; number_of_response:1; }","duration":"144.504759ms","start":"2026-07-16T06:58:55.893084Z","end":"2026-07-16T06:58:56.037589Z","steps":["trace[1037655411] 'process raft request' (duration: 144.390677ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:58:56.037818Z","caller":"traceutil/trace.go:171","msg":"trace[1882654667] linearizableReadLoop","detail":"{readStateIndex:6171; appliedIndex:6164; }","duration":"140.129316ms","start":"2026-07-16T06:58:55.897676Z","end":"2026-07-16T06:58:56.037805Z","steps":["trace[1882654667] 'read index received' (duration: 54.57682ms)","trace[1882654667] 'applied index is now lower than readState.Index' (duration: 85.551746ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:58:56.037857Z","caller":"traceutil/trace.go:171","msg":"trace[2100472533] transaction","detail":"{read_only:false; response_revision:5956; number_of_response:1; }","duration":"143.49958ms","start":"2026-07-16T06:58:55.89432Z","end":"2026-07-16T06:58:56.03782Z","steps":["trace[2100472533] 'process raft request' (duration: 143.372477ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:58:56.038003Z","caller":"traceutil/trace.go:171","msg":"trace[38471192] transaction","detail":"{read_only:false; response_revision:5957; number_of_response:1; }","duration":"142.809167ms","start":"2026-07-16T06:58:55.895186Z","end":"2026-07-16T06:58:56.037995Z","steps":["trace[38471192] 'process raft request' (duration: 142.547862ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:58:56.038158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.448992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-16T06:58:56.038207Z","caller":"traceutil/trace.go:171","msg":"trace[145642406] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5958; }","duration":"140.547803ms","start":"2026-07-16T06:58:55.897646Z","end":"2026-07-16T06:58:56.038194Z","steps":["trace[145642406] 'agreement among raft nodes before linearized reading' (duration: 140.35656ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:58:56.038216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.425286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-16T06:58:56.038249Z","caller":"traceutil/trace.go:171","msg":"trace[510104102] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5958; }","duration":"135.525398ms","start":"2026-07-16T06:58:55.902713Z","end":"2026-07-16T06:58:56.038239Z","steps":["trace[510104102] 'agreement among raft nodes before linearized reading' (duration: 135.387146ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:58:56.03827Z","caller":"traceutil/trace.go:171","msg":"trace[1447214961] transaction","detail":"{read_only:false; response_revision:5955; number_of_response:1; }","duration":"145.035259ms","start":"2026-07-16T06:58:55.89322Z","end":"2026-07-16T06:58:56.038256Z","steps":["trace[1447214961] 'process raft request' (duration: 144.325055ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:58:56.038405Z","caller":"traceutil/trace.go:171","msg":"trace[403749178] transaction","detail":"{read_only:false; response_revision:5958; number_of_response:1; }","duration":"138.783671ms","start":"2026-07-16T06:58:55.899605Z","end":"2026-07-16T06:58:56.038389Z","steps":["trace[403749178] 'process raft request' (duration: 138.16429ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:58:56.038498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.139888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-d6kwj\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-07-16T06:58:56.038557Z","caller":"traceutil/trace.go:171","msg":"trace[935174459] range","detail":"{range_begin:/registry/pods/openstack/keepalived-d6kwj; range_end:; response_count:1; response_revision:5958; }","duration":"129.21939ms","start":"2026-07-16T06:58:55.909321Z","end":"2026-07-16T06:58:56.03854Z","steps":["trace[935174459] 'agreement among raft nodes before linearized reading' (duration: 129.062987ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:59:08.218563Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2975} {"level":"info","ts":"2026-07-16T06:59:08.288941Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2975,"took":"68.800639ms","hash":1221496204,"current-db-size-bytes":58470400,"current-db-size":"58 MB","current-db-size-in-use-bytes":34226176,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-16T06:59:08.289004Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1221496204,"revision":2975,"compact-revision":-1} {"level":"info","ts":"2026-07-16T07:04:08.224443Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6049} {"level":"info","ts":"2026-07-16T07:04:08.326772Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6049,"took":"100.40393ms","hash":57200420,"current-db-size-bytes":58470400,"current-db-size":"58 MB","current-db-size-in-use-bytes":21889024,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-07-16T07:04:08.326853Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":57200420,"revision":6049,"compact-revision":2975} {"level":"info","ts":"2026-07-16T07:04:11.846098Z","caller":"traceutil/trace.go:171","msg":"trace[857569388] transaction","detail":"{read_only:false; response_revision:8158; number_of_response:1; }","duration":"159.837065ms","start":"2026-07-16T07:04:11.686219Z","end":"2026-07-16T07:04:11.846056Z","steps":["trace[857569388] 'process raft request' (duration: 159.597941ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:04:11.920571Z","caller":"traceutil/trace.go:171","msg":"trace[680506077] linearizableReadLoop","detail":"{readStateIndex:8450; appliedIndex:8448; }","duration":"126.203603ms","start":"2026-07-16T07:04:11.794324Z","end":"2026-07-16T07:04:11.920528Z","steps":["trace[680506077] 'read index received' (duration: 51.434454ms)","trace[680506077] 'applied index is now lower than readState.Index' (duration: 74.766999ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:04:11.920633Z","caller":"traceutil/trace.go:171","msg":"trace[742156866] transaction","detail":"{read_only:false; response_revision:8159; number_of_response:1; }","duration":"234.115186ms","start":"2026-07-16T07:04:11.686472Z","end":"2026-07-16T07:04:11.920587Z","steps":["trace[742156866] 'process raft request' (duration: 206.669451ms)","trace[742156866] 'compare' (duration: 27.1674ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T07:04:11.920934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.599191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-16T07:04:11.921091Z","caller":"traceutil/trace.go:171","msg":"trace[324726558] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8159; }","duration":"126.810114ms","start":"2026-07-16T07:04:11.794262Z","end":"2026-07-16T07:04:11.921072Z","steps":["trace[324726558] 'agreement among raft nodes before linearized reading' (duration: 126.514268ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:04:19.108885Z","caller":"traceutil/trace.go:171","msg":"trace[1218056886] transaction","detail":"{read_only:false; response_revision:8325; number_of_response:1; }","duration":"105.197148ms","start":"2026-07-16T07:04:19.003636Z","end":"2026-07-16T07:04:19.108833Z","steps":["trace[1218056886] 'process raft request' (duration: 104.861212ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:04:19.117394Z","caller":"traceutil/trace.go:171","msg":"trace[444173639] transaction","detail":"{read_only:false; response_revision:8326; number_of_response:1; }","duration":"111.324996ms","start":"2026-07-16T07:04:19.006035Z","end":"2026-07-16T07:04:19.11736Z","steps":["trace[444173639] 'process raft request' (duration: 111.121992ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:04:32.474323Z","caller":"traceutil/trace.go:171","msg":"trace[111245260] transaction","detail":"{read_only:false; response_revision:8399; number_of_response:1; }","duration":"101.798653ms","start":"2026-07-16T07:04:32.372494Z","end":"2026-07-16T07:04:32.474293Z","steps":["trace[111245260] 'process raft request' (duration: 101.63217ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:04:43.256474Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002237.wal"} {"level":"warn","ts":"2026-07-16T07:05:00.409386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.879949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228829"} {"level":"info","ts":"2026-07-16T07:05:00.409471Z","caller":"traceutil/trace.go:171","msg":"trace[1003684642] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8602; }","duration":"140.985281ms","start":"2026-07-16T07:05:00.268468Z","end":"2026-07-16T07:05:00.409453Z","steps":["trace[1003684642] 'range keys from in-memory index tree' (duration: 140.499383ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:05:00.41032Z","caller":"traceutil/trace.go:171","msg":"trace[1153677873] transaction","detail":"{read_only:false; response_revision:8603; number_of_response:1; }","duration":"140.248799ms","start":"2026-07-16T07:05:00.270056Z","end":"2026-07-16T07:05:00.410305Z","steps":["trace[1153677873] 'process raft request' (duration: 84.895182ms)","trace[1153677873] 'compare' (duration: 55.273996ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:05:04.327793Z","caller":"traceutil/trace.go:171","msg":"trace[1892461126] transaction","detail":"{read_only:false; response_revision:8623; number_of_response:1; }","duration":"102.799774ms","start":"2026-07-16T07:05:04.224963Z","end":"2026-07-16T07:05:04.327762Z","steps":["trace[1892461126] 'process raft request' (duration: 102.58263ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:05:04.535451Z","caller":"traceutil/trace.go:171","msg":"trace[1675533545] linearizableReadLoop","detail":"{readStateIndex:8928; appliedIndex:8927; }","duration":"100.664463ms","start":"2026-07-16T07:05:04.434767Z","end":"2026-07-16T07:05:04.535431Z","steps":["trace[1675533545] 'read index received' (duration: 22.627263ms)","trace[1675533545] 'applied index is now lower than readState.Index' (duration: 78.03594ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:05:04.535606Z","caller":"traceutil/trace.go:171","msg":"trace[1108828996] transaction","detail":"{read_only:false; response_revision:8624; number_of_response:1; }","duration":"202.915844ms","start":"2026-07-16T07:05:04.332637Z","end":"2026-07-16T07:05:04.535553Z","steps":["trace[1108828996] 'process raft request' (duration: 124.68565ms)","trace[1108828996] 'compare' (duration: 77.969989ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T07:05:04.535675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.893007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-16T07:05:04.535717Z","caller":"traceutil/trace.go:171","msg":"trace[1220734469] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8624; }","duration":"100.987859ms","start":"2026-07-16T07:05:04.434717Z","end":"2026-07-16T07:05:04.535705Z","steps":["trace[1220734469] 'agreement among raft nodes before linearized reading' (duration: 100.830446ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:05:13.036431Z","caller":"traceutil/trace.go:171","msg":"trace[1003067331] linearizableReadLoop","detail":"{readStateIndex:9020; appliedIndex:9019; }","duration":"103.281292ms","start":"2026-07-16T07:05:12.93311Z","end":"2026-07-16T07:05:13.036392Z","steps":["trace[1003067331] 'read index received' (duration: 102.980406ms)","trace[1003067331] 'applied index is now lower than readState.Index' (duration: 299.426µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:05:13.036535Z","caller":"traceutil/trace.go:171","msg":"trace[2101493541] transaction","detail":"{read_only:false; response_revision:8712; number_of_response:1; }","duration":"128.047975ms","start":"2026-07-16T07:05:12.908437Z","end":"2026-07-16T07:05:13.036485Z","steps":["trace[2101493541] 'process raft request' (duration: 127.705879ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:05:13.036647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.498325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T07:05:13.036724Z","caller":"traceutil/trace.go:171","msg":"trace[852719572] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8712; }","duration":"103.604597ms","start":"2026-07-16T07:05:12.933102Z","end":"2026-07-16T07:05:13.036706Z","steps":["trace[852719572] 'agreement among raft nodes before linearized reading' (duration: 103.437034ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:05:13.316807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.354726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T07:05:13.316924Z","caller":"traceutil/trace.go:171","msg":"trace[1503914758] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:8712; }","duration":"178.54705ms","start":"2026-07-16T07:05:13.138349Z","end":"2026-07-16T07:05:13.316896Z","steps":["trace[1503914758] 'count revisions from in-memory index tree' (duration: 178.232053ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:05:13.960646Z","caller":"traceutil/trace.go:171","msg":"trace[1091981643] transaction","detail":"{read_only:false; response_revision:8721; number_of_response:1; }","duration":"118.199388ms","start":"2026-07-16T07:05:13.842418Z","end":"2026-07-16T07:05:13.960617Z","steps":["trace[1091981643] 'process raft request' (duration: 118.013864ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:05:14.533147Z","caller":"traceutil/trace.go:171","msg":"trace[1825089866] transaction","detail":"{read_only:false; response_revision:8723; number_of_response:1; }","duration":"101.842755ms","start":"2026-07-16T07:05:14.431266Z","end":"2026-07-16T07:05:14.533108Z","steps":["trace[1825089866] 'process raft request' (duration: 54.729765ms)","trace[1825089866] 'compare' (duration: 46.912676ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:06:28.916708Z","caller":"traceutil/trace.go:171","msg":"trace[1367123094] transaction","detail":"{read_only:false; response_revision:9458; number_of_response:1; }","duration":"113.697177ms","start":"2026-07-16T07:06:28.802982Z","end":"2026-07-16T07:06:28.916679Z","steps":["trace[1367123094] 'process raft request' (duration: 113.500403ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:06:29.065175Z","caller":"traceutil/trace.go:171","msg":"trace[1657665915] transaction","detail":"{read_only:false; response_revision:9459; number_of_response:1; }","duration":"188.309735ms","start":"2026-07-16T07:06:28.876825Z","end":"2026-07-16T07:06:29.065134Z","steps":["trace[1657665915] 'process raft request' (duration: 187.820235ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:06:57.222071Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-16T07:06:57.227369Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-16T07:06:57.227442Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-16T07:09:08.23157Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8134} {"level":"info","ts":"2026-07-16T07:09:08.298774Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8134,"took":"65.183474ms","hash":2498568203,"current-db-size-bytes":58470400,"current-db-size":"58 MB","current-db-size-in-use-bytes":27996160,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-07-16T07:09:08.298831Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2498568203,"revision":8134,"compact-revision":6049} {"level":"info","ts":"2026-07-16T07:11:45.839959Z","caller":"traceutil/trace.go:171","msg":"trace[1217691997] transaction","detail":"{read_only:false; response_revision:11775; number_of_response:1; }","duration":"148.205828ms","start":"2026-07-16T07:11:45.691726Z","end":"2026-07-16T07:11:45.839932Z","steps":["trace[1217691997] 'process raft request' (duration: 147.996694ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:12:03.202257Z","caller":"traceutil/trace.go:171","msg":"trace[1479624020] transaction","detail":"{read_only:false; response_revision:11871; number_of_response:1; }","duration":"247.626054ms","start":"2026-07-16T07:12:02.954579Z","end":"2026-07-16T07:12:03.202205Z","steps":["trace[1479624020] 'process raft request' (duration: 220.16686ms)","trace[1479624020] 'compare' (duration: 26.916874ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:12:03.20227Z","caller":"traceutil/trace.go:171","msg":"trace[1173274902] transaction","detail":"{read_only:false; response_revision:11872; number_of_response:1; }","duration":"227.48121ms","start":"2026-07-16T07:12:02.974757Z","end":"2026-07-16T07:12:03.202238Z","steps":["trace[1173274902] 'process raft request' (duration: 227.364997ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:12:03.202443Z","caller":"traceutil/trace.go:171","msg":"trace[607053202] transaction","detail":"{read_only:false; response_revision:11873; number_of_response:1; }","duration":"226.366899ms","start":"2026-07-16T07:12:02.97604Z","end":"2026-07-16T07:12:03.202407Z","steps":["trace[607053202] 'process raft request' (duration: 226.158335ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:14:08.240662Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10499} {"level":"info","ts":"2026-07-16T07:14:08.32044Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10499,"took":"76.85388ms","hash":3201717508,"current-db-size-bytes":58470400,"current-db-size":"58 MB","current-db-size-in-use-bytes":26365952,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-07-16T07:14:08.32055Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3201717508,"revision":10499,"compact-revision":8134} {"level":"info","ts":"2026-07-16T07:18:38.028838Z","caller":"traceutil/trace.go:171","msg":"trace[295937347] transaction","detail":"{read_only:false; response_revision:14496; number_of_response:1; }","duration":"136.86024ms","start":"2026-07-16T07:18:37.891953Z","end":"2026-07-16T07:18:38.028813Z","steps":["trace[295937347] 'process raft request' (duration: 136.698927ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:18:38.099872Z","caller":"traceutil/trace.go:171","msg":"trace[1628492973] transaction","detail":"{read_only:false; response_revision:14497; number_of_response:1; }","duration":"202.244172ms","start":"2026-07-16T07:18:37.89754Z","end":"2026-07-16T07:18:38.099784Z","steps":["trace[1628492973] 'process raft request' (duration: 200.336636ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:18:54.128797Z","caller":"traceutil/trace.go:171","msg":"trace[307363818] linearizableReadLoop","detail":"{readStateIndex:15097; appliedIndex:15096; }","duration":"116.231585ms","start":"2026-07-16T07:18:54.01254Z","end":"2026-07-16T07:18:54.128771Z","steps":["trace[307363818] 'read index received' (duration: 116.131983ms)","trace[307363818] 'applied index is now lower than readState.Index' (duration: 98.522µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:18:54.128839Z","caller":"traceutil/trace.go:171","msg":"trace[209677871] transaction","detail":"{read_only:false; response_revision:14593; number_of_response:1; }","duration":"116.396498ms","start":"2026-07-16T07:18:54.012407Z","end":"2026-07-16T07:18:54.128804Z","steps":["trace[209677871] 'process raft request' (duration: 116.206134ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:18:54.129059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.475269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T07:18:54.129195Z","caller":"traceutil/trace.go:171","msg":"trace[839435268] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14593; }","duration":"116.687523ms","start":"2026-07-16T07:18:54.012479Z","end":"2026-07-16T07:18:54.129166Z","steps":["trace[839435268] 'agreement among raft nodes before linearized reading' (duration: 116.424709ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:18:55.096355Z","caller":"traceutil/trace.go:171","msg":"trace[401825571] linearizableReadLoop","detail":"{readStateIndex:15103; appliedIndex:15102; }","duration":"164.569021ms","start":"2026-07-16T07:18:54.931767Z","end":"2026-07-16T07:18:55.096336Z","steps":["trace[401825571] 'read index received' (duration: 164.445249ms)","trace[401825571] 'applied index is now lower than readState.Index' (duration: 123.182µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:18:55.096442Z","caller":"traceutil/trace.go:171","msg":"trace[764954308] transaction","detail":"{read_only:false; response_revision:14599; number_of_response:1; }","duration":"168.330753ms","start":"2026-07-16T07:18:54.928104Z","end":"2026-07-16T07:18:55.096435Z","steps":["trace[764954308] 'process raft request' (duration: 168.102228ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:18:55.096635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.870827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-d6kwj\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-07-16T07:18:55.096656Z","caller":"traceutil/trace.go:171","msg":"trace[1435724731] range","detail":"{range_begin:/registry/pods/openstack/keepalived-d6kwj; range_end:; response_count:1; response_revision:14599; }","duration":"164.965659ms","start":"2026-07-16T07:18:54.931684Z","end":"2026-07-16T07:18:55.09665Z","steps":["trace[1435724731] 'agreement among raft nodes before linearized reading' (duration: 164.844697ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:18:55.096824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.179314ms","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-07-16T07:18:55.096843Z","caller":"traceutil/trace.go:171","msg":"trace[524006016] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14599; }","duration":"117.226284ms","start":"2026-07-16T07:18:54.97961Z","end":"2026-07-16T07:18:55.096837Z","steps":["trace[524006016] 'agreement among raft nodes before linearized reading' (duration: 117.169203ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:18:55.096968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.23581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-07-16T07:18:55.096981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.528087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-16T07:18:55.097042Z","caller":"traceutil/trace.go:171","msg":"trace[892188472] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14599; }","duration":"110.608658ms","start":"2026-07-16T07:18:54.986413Z","end":"2026-07-16T07:18:55.097022Z","steps":["trace[892188472] 'agreement among raft nodes before linearized reading' (duration: 110.439815ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:18:55.097064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.661327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-16T07:18:55.097082Z","caller":"traceutil/trace.go:171","msg":"trace[81764471] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14599; }","duration":"111.680628ms","start":"2026-07-16T07:18:54.985396Z","end":"2026-07-16T07:18:55.097076Z","steps":["trace[81764471] 'agreement among raft nodes before linearized reading' (duration: 111.622587ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:18:55.097Z","caller":"traceutil/trace.go:171","msg":"trace[1427744152] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14599; }","duration":"111.293341ms","start":"2026-07-16T07:18:54.985697Z","end":"2026-07-16T07:18:55.096991Z","steps":["trace[1427744152] 'agreement among raft nodes before linearized reading' (duration: 111.22346ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:18:55.274928Z","caller":"traceutil/trace.go:171","msg":"trace[2014015287] transaction","detail":"{read_only:false; response_revision:14600; number_of_response:1; }","duration":"174.083813ms","start":"2026-07-16T07:18:55.100796Z","end":"2026-07-16T07:18:55.27488Z","steps":["trace[2014015287] 'process raft request' (duration: 140.903218ms)","trace[2014015287] 'compare' (duration: 32.861809ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:18:55.283763Z","caller":"traceutil/trace.go:171","msg":"trace[1472248726] transaction","detail":"{read_only:false; response_revision:14601; number_of_response:1; }","duration":"181.935103ms","start":"2026-07-16T07:18:55.101812Z","end":"2026-07-16T07:18:55.283747Z","steps":["trace[1472248726] 'process raft request' (duration: 181.814991ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:18:55.284072Z","caller":"traceutil/trace.go:171","msg":"trace[232062181] transaction","detail":"{read_only:false; response_revision:14602; number_of_response:1; }","duration":"182.091696ms","start":"2026-07-16T07:18:55.101939Z","end":"2026-07-16T07:18:55.284031Z","steps":["trace[232062181] 'process raft request' (duration: 181.77098ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:18:55.284088Z","caller":"traceutil/trace.go:171","msg":"trace[8667454] transaction","detail":"{read_only:false; response_revision:14603; number_of_response:1; }","duration":"181.77109ms","start":"2026-07-16T07:18:55.102279Z","end":"2026-07-16T07:18:55.28405Z","steps":["trace[8667454] 'process raft request' (duration: 181.621667ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:19:05.083284Z","caller":"traceutil/trace.go:171","msg":"trace[1073697961] transaction","detail":"{read_only:false; response_revision:14770; number_of_response:1; }","duration":"171.057395ms","start":"2026-07-16T07:19:04.912203Z","end":"2026-07-16T07:19:05.08326Z","steps":["trace[1073697961] 'process raft request' (duration: 170.907462ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:19:05.177389Z","caller":"traceutil/trace.go:171","msg":"trace[1021919855] linearizableReadLoop","detail":"{readStateIndex:15278; appliedIndex:15276; }","duration":"199.987558ms","start":"2026-07-16T07:19:04.977348Z","end":"2026-07-16T07:19:05.177335Z","steps":["trace[1021919855] 'read index received' (duration: 105.761435ms)","trace[1021919855] 'applied index is now lower than readState.Index' (duration: 94.224333ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:19:05.177423Z","caller":"traceutil/trace.go:171","msg":"trace[405677109] transaction","detail":"{read_only:false; response_revision:14771; number_of_response:1; }","duration":"247.07918ms","start":"2026-07-16T07:19:04.9303Z","end":"2026-07-16T07:19:05.177379Z","steps":["trace[405677109] 'process raft request' (duration: 174.873839ms)","trace[405677109] 'compare' (duration: 71.983477ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T07:19:05.177771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.391086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-07-16T07:19:05.177836Z","caller":"traceutil/trace.go:171","msg":"trace[1494507350] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:14771; }","duration":"200.511248ms","start":"2026-07-16T07:19:04.977306Z","end":"2026-07-16T07:19:05.177818Z","steps":["trace[1494507350] 'agreement among raft nodes before linearized reading' (duration: 200.203533ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:19:05.390675Z","caller":"traceutil/trace.go:171","msg":"trace[686486452] linearizableReadLoop","detail":"{readStateIndex:15279; appliedIndex:15278; }","duration":"213.158891ms","start":"2026-07-16T07:19:05.177471Z","end":"2026-07-16T07:19:05.39063Z","steps":["trace[686486452] 'read index received' (duration: 208.020633ms)","trace[686486452] 'applied index is now lower than readState.Index' (duration: 5.132388ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:19:05.390719Z","caller":"traceutil/trace.go:171","msg":"trace[223081480] transaction","detail":"{read_only:false; response_revision:14772; number_of_response:1; }","duration":"260.490737ms","start":"2026-07-16T07:19:05.13019Z","end":"2026-07-16T07:19:05.390681Z","steps":["trace[223081480] 'process raft request' (duration: 255.422301ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:19:05.390974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.126413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T07:19:05.391069Z","caller":"traceutil/trace.go:171","msg":"trace[429168084] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14772; }","duration":"386.284246ms","start":"2026-07-16T07:19:05.00476Z","end":"2026-07-16T07:19:05.391044Z","steps":["trace[429168084] 'agreement among raft nodes before linearized reading' (duration: 386.082462ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:19:05.391091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.374366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-d6kwj\" ","response":"range_response_count:1 size:6520"} {"level":"warn","ts":"2026-07-16T07:19:05.391121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:19:05.004728Z","time spent":"386.381048ms","remote":"127.0.0.1:49360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-16T07:19:05.391137Z","caller":"traceutil/trace.go:171","msg":"trace[423088748] range","detail":"{range_begin:/registry/pods/openstack/keepalived-d6kwj; range_end:; response_count:1; response_revision:14772; }","duration":"213.490138ms","start":"2026-07-16T07:19:05.177634Z","end":"2026-07-16T07:19:05.391125Z","steps":["trace[423088748] 'agreement among raft nodes before linearized reading' (duration: 213.236704ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:19:05.391556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.599542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-7c295dbf-1c94-4461-bb30-389e11ac83ec\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-07-16T07:19:05.391602Z","caller":"traceutil/trace.go:171","msg":"trace[1235031255] range","detail":"{range_begin:/registry/persistentvolumes/pvc-7c295dbf-1c94-4461-bb30-389e11ac83ec; range_end:; response_count:1; response_revision:14772; }","duration":"210.662513ms","start":"2026-07-16T07:19:05.180925Z","end":"2026-07-16T07:19:05.391588Z","steps":["trace[1235031255] 'agreement among raft nodes before linearized reading' (duration: 210.5007ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:19:08.247627Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12715} {"level":"info","ts":"2026-07-16T07:19:08.325627Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12715,"took":"75.21593ms","hash":3214764836,"current-db-size-bytes":58470400,"current-db-size":"58 MB","current-db-size-in-use-bytes":28028928,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-07-16T07:19:08.325705Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3214764836,"revision":12715,"compact-revision":10499} {"level":"info","ts":"2026-07-16T07:20:11.150158Z","caller":"traceutil/trace.go:171","msg":"trace[353106747] transaction","detail":"{read_only:false; response_revision:15678; number_of_response:1; }","duration":"157.587481ms","start":"2026-07-16T07:20:10.992538Z","end":"2026-07-16T07:20:11.150126Z","steps":["trace[353106747] 'process raft request' (duration: 157.383667ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:20:11.151019Z","caller":"traceutil/trace.go:171","msg":"trace[176078575] linearizableReadLoop","detail":"{readStateIndex:16212; appliedIndex:16210; }","duration":"151.567385ms","start":"2026-07-16T07:20:10.999379Z","end":"2026-07-16T07:20:11.150947Z","steps":["trace[176078575] 'read index received' (duration: 150.546395ms)","trace[176078575] 'applied index is now lower than readState.Index' (duration: 1.01943ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:20:11.151058Z","caller":"traceutil/trace.go:171","msg":"trace[647408156] transaction","detail":"{read_only:false; response_revision:15679; number_of_response:1; }","duration":"151.996852ms","start":"2026-07-16T07:20:10.99902Z","end":"2026-07-16T07:20:11.151017Z","steps":["trace[647408156] 'process raft request' (duration: 151.607115ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:20:11.151297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.895531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-07-16T07:20:11.151366Z","caller":"traceutil/trace.go:171","msg":"trace[2128629904] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15679; }","duration":"152.014392ms","start":"2026-07-16T07:20:10.999333Z","end":"2026-07-16T07:20:11.151347Z","steps":["trace[2128629904] 'agreement among raft nodes before linearized reading' (duration: 151.761848ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:20:36.186235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.744668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-kjqt4\" ","response":"range_response_count:1 size:22089"} {"level":"warn","ts":"2026-07-16T07:20:36.18625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.416382ms","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-07-16T07:20:36.186377Z","caller":"traceutil/trace.go:171","msg":"trace[1833271461] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-kjqt4; range_end:; response_count:1; response_revision:15812; }","duration":"204.89041ms","start":"2026-07-16T07:20:35.981423Z","end":"2026-07-16T07:20:36.186313Z","steps":["trace[1833271461] 'range keys from in-memory index tree' (duration: 204.482522ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:20:36.186325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.277221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-07-16T07:20:36.186404Z","caller":"traceutil/trace.go:171","msg":"trace[717217171] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15812; }","duration":"151.629816ms","start":"2026-07-16T07:20:36.034742Z","end":"2026-07-16T07:20:36.186372Z","steps":["trace[717217171] 'range keys from in-memory index tree' (duration: 151.275129ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:20:36.186467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.673386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-07-16T07:20:36.186536Z","caller":"traceutil/trace.go:171","msg":"trace[2006074131] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15812; }","duration":"151.775119ms","start":"2026-07-16T07:20:36.034742Z","end":"2026-07-16T07:20:36.186517Z","steps":["trace[2006074131] 'range keys from in-memory index tree' (duration: 151.452642ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:20:36.186476Z","caller":"traceutil/trace.go:171","msg":"trace[226129466] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15812; }","duration":"148.466005ms","start":"2026-07-16T07:20:36.037982Z","end":"2026-07-16T07:20:36.186448Z","steps":["trace[226129466] 'range keys from in-memory index tree' (duration: 148.083688ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:20:36.187054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.251796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:79 size:769682"} {"level":"info","ts":"2026-07-16T07:20:36.187114Z","caller":"traceutil/trace.go:171","msg":"trace[36056309] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:79; response_revision:15812; }","duration":"234.354627ms","start":"2026-07-16T07:20:35.952746Z","end":"2026-07-16T07:20:36.187101Z","steps":["trace[36056309] 'range keys from in-memory index tree' (duration: 233.295457ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:22:07.658945Z","caller":"traceutil/trace.go:171","msg":"trace[1140629689] transaction","detail":"{read_only:false; response_revision:16378; number_of_response:1; }","duration":"109.391294ms","start":"2026-07-16T07:22:07.549514Z","end":"2026-07-16T07:22:07.658905Z","steps":["trace[1140629689] 'process raft request' (duration: 72.265479ms)","trace[1140629689] 'compare' (duration: 36.726756ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:24:08.2543Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14803} {"level":"info","ts":"2026-07-16T07:24:08.341079Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14803,"took":"83.471457ms","hash":2439312925,"current-db-size-bytes":58470400,"current-db-size":"58 MB","current-db-size-in-use-bytes":30515200,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-16T07:24:08.341166Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2439312925,"revision":14803,"compact-revision":12715} {"level":"info","ts":"2026-07-16T07:26:20.483598Z","caller":"traceutil/trace.go:171","msg":"trace[1007752430] transaction","detail":"{read_only:false; response_revision:18258; number_of_response:1; }","duration":"124.769542ms","start":"2026-07-16T07:26:20.358783Z","end":"2026-07-16T07:26:20.483553Z","steps":["trace[1007752430] 'process raft request' (duration: 124.509907ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:26:28.618453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.650244ms","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-07-16T07:26:28.61857Z","caller":"traceutil/trace.go:171","msg":"trace[1128789212] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18299; }","duration":"253.822167ms","start":"2026-07-16T07:26:28.36472Z","end":"2026-07-16T07:26:28.618543Z","steps":["trace[1128789212] 'range keys from in-memory index tree' (duration: 253.432329ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:26:28.618598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.2777ms","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-07-16T07:26:28.618718Z","caller":"traceutil/trace.go:171","msg":"trace[418679127] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18299; }","duration":"115.453543ms","start":"2026-07-16T07:26:28.503236Z","end":"2026-07-16T07:26:28.618689Z","steps":["trace[418679127] 'range keys from in-memory index tree' (duration: 115.044625ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:26:28.618915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.627221ms","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-07-16T07:26:28.618989Z","caller":"traceutil/trace.go:171","msg":"trace[1486270898] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18299; }","duration":"256.743212ms","start":"2026-07-16T07:26:28.362228Z","end":"2026-07-16T07:26:28.618971Z","steps":["trace[1486270898] 'range keys from in-memory index tree' (duration: 256.360685ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:26:28.618924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.596056ms","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-07-16T07:26:28.619107Z","caller":"traceutil/trace.go:171","msg":"trace[1135845724] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:18299; }","duration":"208.78503ms","start":"2026-07-16T07:26:28.410278Z","end":"2026-07-16T07:26:28.619063Z","steps":["trace[1135845724] 'count revisions from in-memory index tree' (duration: 208.535015ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:26:28.619104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.333411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-kjqt4\" ","response":"range_response_count:1 size:22090"} {"level":"info","ts":"2026-07-16T07:26:28.61924Z","caller":"traceutil/trace.go:171","msg":"trace[2106939578] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-kjqt4; range_end:; response_count:1; response_revision:18299; }","duration":"235.527465ms","start":"2026-07-16T07:26:28.383679Z","end":"2026-07-16T07:26:28.619206Z","steps":["trace[2106939578] 'range keys from in-memory index tree' (duration: 235.012135ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:26:28.751996Z","caller":"traceutil/trace.go:171","msg":"trace[1706505051] transaction","detail":"{read_only:false; response_revision:18300; number_of_response:1; }","duration":"207.268621ms","start":"2026-07-16T07:26:28.544696Z","end":"2026-07-16T07:26:28.751965Z","steps":["trace[1706505051] 'process raft request' (duration: 207.014156ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:26:28.806882Z","caller":"traceutil/trace.go:171","msg":"trace[1093379795] transaction","detail":"{read_only:false; response_revision:18301; number_of_response:1; }","duration":"183.176216ms","start":"2026-07-16T07:26:28.623659Z","end":"2026-07-16T07:26:28.806835Z","steps":["trace[1093379795] 'process raft request' (duration: 182.86638ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:26:28.80708Z","caller":"traceutil/trace.go:171","msg":"trace[714228499] linearizableReadLoop","detail":"{readStateIndex:18925; appliedIndex:18923; }","duration":"179.783891ms","start":"2026-07-16T07:26:28.627258Z","end":"2026-07-16T07:26:28.807042Z","steps":["trace[714228499] 'read index received' (duration: 124.567959ms)","trace[714228499] 'applied index is now lower than readState.Index' (duration: 55.214542ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T07:26:28.80849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.207799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:95 size:940051"} {"level":"info","ts":"2026-07-16T07:26:28.80857Z","caller":"traceutil/trace.go:171","msg":"trace[98819403] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:95; response_revision:18303; }","duration":"181.346132ms","start":"2026-07-16T07:26:28.627207Z","end":"2026-07-16T07:26:28.808553Z","steps":["trace[98819403] 'agreement among raft nodes before linearized reading' (duration: 179.976275ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:28:06.295059Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-16T07:28:06.300915Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-07-16T07:28:06.301038Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-07-16T07:29:08.260753Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17415} {"level":"info","ts":"2026-07-16T07:29:08.361233Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17415,"took":"96.912039ms","hash":1056221426,"current-db-size-bytes":58470400,"current-db-size":"58 MB","current-db-size-in-use-bytes":38584320,"current-db-size-in-use":"39 MB"} {"level":"info","ts":"2026-07-16T07:29:08.361301Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1056221426,"revision":17415,"compact-revision":14803} {"level":"info","ts":"2026-07-16T07:33:26.310887Z","caller":"traceutil/trace.go:171","msg":"trace[1496725115] transaction","detail":"{read_only:false; response_revision:21450; number_of_response:1; }","duration":"100.459662ms","start":"2026-07-16T07:33:26.210397Z","end":"2026-07-16T07:33:26.310857Z","steps":["trace[1496725115] 'process raft request' (duration: 100.220867ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:33:26.522506Z","caller":"traceutil/trace.go:171","msg":"trace[875661582] transaction","detail":"{read_only:false; response_revision:21451; number_of_response:1; }","duration":"199.995145ms","start":"2026-07-16T07:33:26.322475Z","end":"2026-07-16T07:33:26.52247Z","steps":["trace[875661582] 'process raft request' (duration: 142.053355ms)","trace[875661582] 'compare' (duration: 57.802237ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:33:26.567748Z","caller":"traceutil/trace.go:171","msg":"trace[578017999] transaction","detail":"{read_only:false; response_revision:21453; number_of_response:1; }","duration":"126.146278ms","start":"2026-07-16T07:33:26.441568Z","end":"2026-07-16T07:33:26.567714Z","steps":["trace[578017999] 'process raft request' (duration: 126.074066ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:33:26.56803Z","caller":"traceutil/trace.go:171","msg":"trace[888311046] transaction","detail":"{read_only:false; response_revision:21452; number_of_response:1; }","duration":"136.62264ms","start":"2026-07-16T07:33:26.431361Z","end":"2026-07-16T07:33:26.567984Z","steps":["trace[888311046] 'process raft request' (duration: 136.067689ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:33:26.842334Z","caller":"traceutil/trace.go:171","msg":"trace[2005525899] transaction","detail":"{read_only:false; response_revision:21454; number_of_response:1; }","duration":"193.172982ms","start":"2026-07-16T07:33:26.649133Z","end":"2026-07-16T07:33:26.842306Z","steps":["trace[2005525899] 'process raft request' (duration: 192.989619ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:33:27.110229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.623519ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-07-16T07:33:27.110343Z","caller":"traceutil/trace.go:171","msg":"trace[1963990498] linearizableReadLoop","detail":"{readStateIndex:22181; appliedIndex:22180; }","duration":"138.970915ms","start":"2026-07-16T07:33:26.971353Z","end":"2026-07-16T07:33:27.110324Z","steps":["trace[1963990498] 'read index received' (duration: 46.381µs)","trace[1963990498] 'applied index is now lower than readState.Index' (duration: 138.922794ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T07:33:27.110489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.995222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T07:33:27.110526Z","caller":"traceutil/trace.go:171","msg":"trace[312929560] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21454; }","duration":"102.061173ms","start":"2026-07-16T07:33:27.008454Z","end":"2026-07-16T07:33:27.110516Z","steps":["trace[312929560] 'agreement among raft nodes before linearized reading' (duration: 101.985421ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:33:27.110634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.279122ms","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-07-16T07:33:27.110711Z","caller":"traceutil/trace.go:171","msg":"trace[1362777870] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21454; }","duration":"139.386073ms","start":"2026-07-16T07:33:26.971305Z","end":"2026-07-16T07:33:27.110691Z","steps":["trace[1362777870] 'agreement among raft nodes before linearized reading' (duration: 139.123488ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:33:27.217597Z","caller":"traceutil/trace.go:171","msg":"trace[761025979] transaction","detail":"{read_only:false; response_revision:21455; number_of_response:1; }","duration":"103.027611ms","start":"2026-07-16T07:33:27.114535Z","end":"2026-07-16T07:33:27.217563Z","steps":["trace[761025979] 'process raft request' (duration: 102.837437ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:33:27.696351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.229465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T07:33:27.696467Z","caller":"traceutil/trace.go:171","msg":"trace[1372131203] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:21456; }","duration":"102.403119ms","start":"2026-07-16T07:33:27.594034Z","end":"2026-07-16T07:33:27.696438Z","steps":["trace[1372131203] 'count revisions from in-memory index tree' (duration: 102.134894ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:34:08.268114Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19767} {"level":"info","ts":"2026-07-16T07:34:08.385986Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19767,"took":"114.251128ms","hash":2842620118,"current-db-size-bytes":58470400,"current-db-size":"58 MB","current-db-size-in-use-bytes":29446144,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-16T07:34:08.386073Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2842620118,"revision":19767,"compact-revision":17415} {"level":"warn","ts":"2026-07-16T07:37:42.286022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.159111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T07:37:42.28613Z","caller":"traceutil/trace.go:171","msg":"trace[770387299] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24027; }","duration":"277.309164ms","start":"2026-07-16T07:37:42.008796Z","end":"2026-07-16T07:37:42.286105Z","steps":["trace[770387299] 'range keys from in-memory index tree' (duration: 277.09832ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:37:42.286171Z","caller":"traceutil/trace.go:171","msg":"trace[302232668] linearizableReadLoop","detail":"{readStateIndex:24832; appliedIndex:24831; }","duration":"189.36771ms","start":"2026-07-16T07:37:42.096767Z","end":"2026-07-16T07:37:42.286135Z","steps":["trace[302232668] 'read index received' (duration: 172.389062ms)","trace[302232668] 'applied index is now lower than readState.Index' (duration: 16.977138ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:37:42.28619Z","caller":"traceutil/trace.go:171","msg":"trace[145282847] transaction","detail":"{read_only:false; response_revision:24028; number_of_response:1; }","duration":"224.935445ms","start":"2026-07-16T07:37:42.061215Z","end":"2026-07-16T07:37:42.28615Z","steps":["trace[145282847] 'process raft request' (duration: 207.998258ms)","trace[145282847] 'compare' (duration: 16.728053ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T07:37:42.28631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.525262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T07:37:42.286348Z","caller":"traceutil/trace.go:171","msg":"trace[448088411] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:24028; }","duration":"189.584423ms","start":"2026-07-16T07:37:42.096754Z","end":"2026-07-16T07:37:42.286338Z","steps":["trace[448088411] 'agreement among raft nodes before linearized reading' (duration: 189.490932ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:39:08.276376Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21910} {"level":"info","ts":"2026-07-16T07:39:08.394686Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21910,"took":"114.626859ms","hash":2644259372,"current-db-size-bytes":58470400,"current-db-size":"58 MB","current-db-size-in-use-bytes":43589632,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-07-16T07:39:08.39473Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2644259372,"revision":21910,"compact-revision":19767} {"level":"info","ts":"2026-07-16T07:40:37.352632Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000067d7.wal"} {"level":"info","ts":"2026-07-16T07:41:31.539882Z","caller":"traceutil/trace.go:171","msg":"trace[310409991] transaction","detail":"{read_only:false; response_revision:26284; number_of_response:1; }","duration":"128.329173ms","start":"2026-07-16T07:41:31.41153Z","end":"2026-07-16T07:41:31.539859Z","steps":["trace[310409991] 'process raft request' (duration: 127.797343ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:31.83869Z","caller":"traceutil/trace.go:171","msg":"trace[193081679] transaction","detail":"{read_only:false; response_revision:26286; number_of_response:1; }","duration":"133.221398ms","start":"2026-07-16T07:41:31.705424Z","end":"2026-07-16T07:41:31.838646Z","steps":["trace[193081679] 'process raft request' (duration: 110.330296ms)","trace[193081679] 'compare' (duration: 22.588276ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T07:41:32.107673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.697351ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-16T07:41:32.107817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.410152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T07:41:32.10781Z","caller":"traceutil/trace.go:171","msg":"trace[642633945] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:26286; }","duration":"141.848014ms","start":"2026-07-16T07:41:31.965939Z","end":"2026-07-16T07:41:32.107787Z","steps":["trace[642633945] 'range keys from in-memory index tree' (duration: 141.667191ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:32.107864Z","caller":"traceutil/trace.go:171","msg":"trace[500898885] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26286; }","duration":"103.495274ms","start":"2026-07-16T07:41:32.004359Z","end":"2026-07-16T07:41:32.107855Z","steps":["trace[500898885] 'range keys from in-memory index tree' (duration: 103.333161ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:33.945511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.075047ms","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-07-16T07:41:33.945595Z","caller":"traceutil/trace.go:171","msg":"trace[1569748769] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26302; }","duration":"102.22052ms","start":"2026-07-16T07:41:33.84336Z","end":"2026-07-16T07:41:33.94558Z","steps":["trace[1569748769] 'range keys from in-memory index tree' (duration: 101.907854ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:34.172008Z","caller":"traceutil/trace.go:171","msg":"trace[297222766] transaction","detail":"{read_only:false; response_revision:26304; number_of_response:1; }","duration":"159.658297ms","start":"2026-07-16T07:41:34.012303Z","end":"2026-07-16T07:41:34.171961Z","steps":["trace[297222766] 'process raft request' (duration: 140.500728ms)","trace[297222766] 'compare' (duration: 18.618078ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:41:34.607168Z","caller":"traceutil/trace.go:171","msg":"trace[1927282832] transaction","detail":"{read_only:false; response_revision:26305; number_of_response:1; }","duration":"349.864303ms","start":"2026-07-16T07:41:34.257242Z","end":"2026-07-16T07:41:34.607106Z","steps":["trace[1927282832] 'process raft request' (duration: 349.72734ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:34.6073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:34.257219Z","time spent":"350.013925ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T07:41:34.608304Z","caller":"traceutil/trace.go:171","msg":"trace[1191624870] transaction","detail":"{read_only:false; response_revision:26306; number_of_response:1; }","duration":"347.211561ms","start":"2026-07-16T07:41:34.26108Z","end":"2026-07-16T07:41:34.608292Z","steps":["trace[1191624870] 'process raft request' (duration: 346.912045ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:34.608364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:34.261059Z","time spent":"347.274292ms","remote":"127.0.0.1:49650","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-07-16T07:41:34.60847Z","caller":"traceutil/trace.go:171","msg":"trace[2054285109] transaction","detail":"{read_only:false; response_revision:26307; number_of_response:1; }","duration":"226.773609ms","start":"2026-07-16T07:41:34.381688Z","end":"2026-07-16T07:41:34.608462Z","steps":["trace[2054285109] 'process raft request' (duration: 226.362501ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:34.608557Z","caller":"traceutil/trace.go:171","msg":"trace[161723089] transaction","detail":"{read_only:false; response_revision:26308; number_of_response:1; }","duration":"216.421541ms","start":"2026-07-16T07:41:34.392129Z","end":"2026-07-16T07:41:34.60855Z","steps":["trace[161723089] 'process raft request' (duration: 215.950692ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:34.608649Z","caller":"traceutil/trace.go:171","msg":"trace[1965312176] transaction","detail":"{read_only:false; response_revision:26309; number_of_response:1; }","duration":"108.185855ms","start":"2026-07-16T07:41:34.500455Z","end":"2026-07-16T07:41:34.608641Z","steps":["trace[1965312176] 'process raft request' (duration: 107.662065ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:40.265502Z","caller":"traceutil/trace.go:171","msg":"trace[1705905237] transaction","detail":"{read_only:false; response_revision:26359; number_of_response:1; }","duration":"237.505227ms","start":"2026-07-16T07:41:40.027974Z","end":"2026-07-16T07:41:40.265479Z","steps":["trace[1705905237] 'process raft request' (duration: 237.362965ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:40.963684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.322525ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-16T07:41:40.964027Z","caller":"traceutil/trace.go:171","msg":"trace[1122146175] transaction","detail":"{read_only:false; response_revision:26361; number_of_response:1; }","duration":"336.325192ms","start":"2026-07-16T07:41:40.627658Z","end":"2026-07-16T07:41:40.963983Z","steps":["trace[1122146175] 'process raft request' (duration: 182.372905ms)","trace[1122146175] 'compare' (duration: 152.830696ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:41:40.964122Z","caller":"traceutil/trace.go:171","msg":"trace[1996989395] transaction","detail":"{read_only:false; response_revision:26363; number_of_response:1; }","duration":"333.047209ms","start":"2026-07-16T07:41:40.631037Z","end":"2026-07-16T07:41:40.964085Z","steps":["trace[1996989395] 'process raft request' (duration: 332.901536ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:40.964196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:40.627623Z","time spent":"336.483024ms","remote":"127.0.0.1:49650","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-07-16T07:41:40.964225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:40.631021Z","time spent":"333.15221ms","remote":"127.0.0.1:49650","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-07-16T07:41:40.964225Z","caller":"traceutil/trace.go:171","msg":"trace[1924572532] linearizableReadLoop","detail":"{readStateIndex:27227; appliedIndex:27224; }","duration":"335.213579ms","start":"2026-07-16T07:41:40.628985Z","end":"2026-07-16T07:41:40.964198Z","steps":["trace[1924572532] 'read index received' (duration: 37.841018ms)","trace[1924572532] 'applied index is now lower than readState.Index' (duration: 297.371391ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:41:40.964402Z","caller":"traceutil/trace.go:171","msg":"trace[11858978] transaction","detail":"{read_only:false; response_revision:26364; number_of_response:1; }","duration":"333.073278ms","start":"2026-07-16T07:41:40.631317Z","end":"2026-07-16T07:41:40.96439Z","steps":["trace[11858978] 'process raft request' (duration: 332.676421ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:40.964397Z","caller":"traceutil/trace.go:171","msg":"trace[2057807656] transaction","detail":"{read_only:false; response_revision:26362; number_of_response:1; }","duration":"336.29347ms","start":"2026-07-16T07:41:40.628087Z","end":"2026-07-16T07:41:40.96438Z","steps":["trace[2057807656] 'process raft request' (duration: 335.720309ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:40.964485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:40.628062Z","time spent":"336.383363ms","remote":"127.0.0.1:49650","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-07-16T07:41:40.964516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:40.631297Z","time spent":"333.1425ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T07:41:40.964719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.710308ms","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-07-16T07:41:40.964764Z","caller":"traceutil/trace.go:171","msg":"trace[1122138012] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26364; }","duration":"335.79829ms","start":"2026-07-16T07:41:40.628952Z","end":"2026-07-16T07:41:40.96475Z","steps":["trace[1122138012] 'agreement among raft nodes before linearized reading' (duration: 335.647867ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:40.964795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:40.628937Z","time spent":"335.850551ms","remote":"127.0.0.1:49650","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":"warn","ts":"2026-07-16T07:41:40.96758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.417799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-16T07:41:40.967644Z","caller":"traceutil/trace.go:171","msg":"trace[1817420124] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26366; }","duration":"300.524091ms","start":"2026-07-16T07:41:40.667105Z","end":"2026-07-16T07:41:40.967629Z","steps":["trace[1817420124] 'agreement among raft nodes before linearized reading' (duration: 300.331257ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:40.967677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:40.667081Z","time spent":"300.587722ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-16T07:41:40.967939Z","caller":"traceutil/trace.go:171","msg":"trace[1677596884] transaction","detail":"{read_only:false; response_revision:26365; number_of_response:1; }","duration":"236.896845ms","start":"2026-07-16T07:41:40.731031Z","end":"2026-07-16T07:41:40.967927Z","steps":["trace[1677596884] 'process raft request' (duration: 236.245212ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:40.968076Z","caller":"traceutil/trace.go:171","msg":"trace[1497420828] transaction","detail":"{read_only:false; response_revision:26366; number_of_response:1; }","duration":"171.486405ms","start":"2026-07-16T07:41:40.796581Z","end":"2026-07-16T07:41:40.968067Z","steps":["trace[1497420828] 'process raft request' (duration: 170.801961ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:40.968167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.904571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-07-16T07:41:40.9684Z","caller":"traceutil/trace.go:171","msg":"trace[1617146262] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26366; }","duration":"297.986332ms","start":"2026-07-16T07:41:40.670217Z","end":"2026-07-16T07:41:40.968204Z","steps":["trace[1617146262] 'agreement among raft nodes before linearized reading' (duration: 297.814459ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:40.968438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.278047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-07-16T07:41:40.968488Z","caller":"traceutil/trace.go:171","msg":"trace[1761526422] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26366; }","duration":"301.364028ms","start":"2026-07-16T07:41:40.66711Z","end":"2026-07-16T07:41:40.968474Z","steps":["trace[1761526422] 'agreement among raft nodes before linearized reading' (duration: 300.998911ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:40.968522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:40.667095Z","time spent":"301.419249ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-16T07:41:41.22366Z","caller":"traceutil/trace.go:171","msg":"trace[1775000263] transaction","detail":"{read_only:false; response_revision:26368; number_of_response:1; }","duration":"251.388465ms","start":"2026-07-16T07:41:40.972243Z","end":"2026-07-16T07:41:41.223631Z","steps":["trace[1775000263] 'process raft request' (duration: 166.636552ms)","trace[1775000263] 'compare' (duration: 84.578379ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:41:41.224052Z","caller":"traceutil/trace.go:171","msg":"trace[178040119] linearizableReadLoop","detail":"{readStateIndex:27235; appliedIndex:27232; }","duration":"218.9979ms","start":"2026-07-16T07:41:41.005032Z","end":"2026-07-16T07:41:41.22403Z","steps":["trace[178040119] 'read index received' (duration: 133.938361ms)","trace[178040119] 'applied index is now lower than readState.Index' (duration: 85.058459ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:41:41.224156Z","caller":"traceutil/trace.go:171","msg":"trace[1987860884] transaction","detail":"{read_only:false; response_revision:26369; number_of_response:1; }","duration":"251.541967ms","start":"2026-07-16T07:41:40.972599Z","end":"2026-07-16T07:41:41.224141Z","steps":["trace[1987860884] 'process raft request' (duration: 250.978927ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:41.22418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.128843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T07:41:41.224144Z","caller":"traceutil/trace.go:171","msg":"trace[621239261] transaction","detail":"{read_only:false; response_revision:26370; number_of_response:1; }","duration":"251.12546ms","start":"2026-07-16T07:41:40.972978Z","end":"2026-07-16T07:41:41.224104Z","steps":["trace[621239261] 'process raft request' (duration: 250.940906ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:41.224215Z","caller":"traceutil/trace.go:171","msg":"trace[881058203] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26370; }","duration":"219.200364ms","start":"2026-07-16T07:41:41.005004Z","end":"2026-07-16T07:41:41.224205Z","steps":["trace[881058203] 'agreement among raft nodes before linearized reading' (duration: 219.126023ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:41.237188Z","caller":"traceutil/trace.go:171","msg":"trace[14340534] transaction","detail":"{read_only:false; response_revision:26371; number_of_response:1; }","duration":"221.718863ms","start":"2026-07-16T07:41:41.01544Z","end":"2026-07-16T07:41:41.237159Z","steps":["trace[14340534] 'process raft request' (duration: 221.505648ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:41.557463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.48028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/keypairs/\" range_end:\"/registry/openstack.k-orc.cloud/keypairs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T07:41:41.557534Z","caller":"traceutil/trace.go:171","msg":"trace[1466585128] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/keypairs/; range_end:/registry/openstack.k-orc.cloud/keypairs0; response_count:0; response_revision:26371; }","duration":"177.613073ms","start":"2026-07-16T07:41:41.379905Z","end":"2026-07-16T07:41:41.557518Z","steps":["trace[1466585128] 'count revisions from in-memory index tree' (duration: 177.374138ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:41.557932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.37215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-07-16T07:41:41.558017Z","caller":"traceutil/trace.go:171","msg":"trace[938887852] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:26371; }","duration":"201.495623ms","start":"2026-07-16T07:41:41.356501Z","end":"2026-07-16T07:41:41.557997Z","steps":["trace[938887852] 'count revisions from in-memory index tree' (duration: 201.299489ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:41.976616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.13456ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-16T07:41:41.976875Z","caller":"traceutil/trace.go:171","msg":"trace[728477771] linearizableReadLoop","detail":"{readStateIndex:27239; appliedIndex:27237; }","duration":"204.917989ms","start":"2026-07-16T07:41:41.771869Z","end":"2026-07-16T07:41:41.976787Z","steps":["trace[728477771] 'read index received' (duration: 50.552184ms)","trace[728477771] 'applied index is now lower than readState.Index' (duration: 154.365205ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:41:41.976863Z","caller":"traceutil/trace.go:171","msg":"trace[1436042574] transaction","detail":"{read_only:false; response_revision:26372; number_of_response:1; }","duration":"344.365736ms","start":"2026-07-16T07:41:41.632367Z","end":"2026-07-16T07:41:41.976732Z","steps":["trace[1436042574] 'process raft request' (duration: 190.027062ms)","trace[1436042574] 'compare' (duration: 153.917096ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:41:41.976898Z","caller":"traceutil/trace.go:171","msg":"trace[1348056515] transaction","detail":"{read_only:false; response_revision:26373; number_of_response:1; }","duration":"286.387939ms","start":"2026-07-16T07:41:41.690465Z","end":"2026-07-16T07:41:41.976853Z","steps":["trace[1348056515] 'process raft request' (duration: 286.218086ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:41.976967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.101312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-16T07:41:41.976998Z","caller":"traceutil/trace.go:171","msg":"trace[296179135] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:26373; }","duration":"205.169654ms","start":"2026-07-16T07:41:41.771818Z","end":"2026-07-16T07:41:41.976988Z","steps":["trace[296179135] 'agreement among raft nodes before linearized reading' (duration: 205.057201ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:41.976995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:41.632349Z","time spent":"344.55478ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T07:41:42.466464Z","caller":"traceutil/trace.go:171","msg":"trace[709384689] transaction","detail":"{read_only:false; response_revision:26375; number_of_response:1; }","duration":"150.564191ms","start":"2026-07-16T07:41:42.315863Z","end":"2026-07-16T07:41:42.466427Z","steps":["trace[709384689] 'process raft request' (duration: 106.692136ms)","trace[709384689] 'compare' (duration: 43.674101ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:41:47.084149Z","caller":"traceutil/trace.go:171","msg":"trace[280004475] transaction","detail":"{read_only:false; response_revision:26417; number_of_response:1; }","duration":"108.552253ms","start":"2026-07-16T07:41:46.975568Z","end":"2026-07-16T07:41:47.08412Z","steps":["trace[280004475] 'process raft request' (duration: 108.384879ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:47.330659Z","caller":"traceutil/trace.go:171","msg":"trace[569369454] transaction","detail":"{read_only:false; response_revision:26419; number_of_response:1; }","duration":"334.646119ms","start":"2026-07-16T07:41:46.995986Z","end":"2026-07-16T07:41:47.330632Z","steps":["trace[569369454] 'process raft request' (duration: 334.555307ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:47.330678Z","caller":"traceutil/trace.go:171","msg":"trace[604854110] transaction","detail":"{read_only:false; response_revision:26418; number_of_response:1; }","duration":"343.405898ms","start":"2026-07-16T07:41:46.987234Z","end":"2026-07-16T07:41:47.33064Z","steps":["trace[604854110] 'process raft request' (duration: 321.799441ms)","trace[604854110] 'compare' (duration: 21.369113ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T07:41:47.330816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:46.995974Z","time spent":"334.759562ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T07:41:47.330868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:46.987203Z","time spent":"343.553721ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T07:41:47.331442Z","caller":"traceutil/trace.go:171","msg":"trace[1239484036] transaction","detail":"{read_only:false; response_revision:26420; number_of_response:1; }","duration":"332.916416ms","start":"2026-07-16T07:41:46.998497Z","end":"2026-07-16T07:41:47.331413Z","steps":["trace[1239484036] 'process raft request' (duration: 332.09366ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:47.331569Z","caller":"traceutil/trace.go:171","msg":"trace[1399632536] transaction","detail":"{read_only:false; response_revision:26421; number_of_response:1; }","duration":"332.512077ms","start":"2026-07-16T07:41:46.999035Z","end":"2026-07-16T07:41:47.331547Z","steps":["trace[1399632536] 'process raft request' (duration: 332.272173ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:47.331586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:46.998482Z","time spent":"333.030588ms","remote":"127.0.0.1:49650","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-07-16T07:41:47.331615Z","caller":"traceutil/trace.go:171","msg":"trace[1098835362] transaction","detail":"{read_only:false; response_revision:26422; number_of_response:1; }","duration":"332.14703ms","start":"2026-07-16T07:41:46.999432Z","end":"2026-07-16T07:41:47.331579Z","steps":["trace[1098835362] 'process raft request' (duration: 332.017757ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:47.331658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:46.999007Z","time spent":"332.60791ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T07:41:47.331681Z","caller":"traceutil/trace.go:171","msg":"trace[603678553] linearizableReadLoop","detail":"{readStateIndex:27289; appliedIndex:27282; }","duration":"328.667093ms","start":"2026-07-16T07:41:47.002985Z","end":"2026-07-16T07:41:47.331652Z","steps":["trace[603678553] 'read index received' (duration: 81.066302ms)","trace[603678553] 'applied index is now lower than readState.Index' (duration: 247.598881ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:41:47.331743Z","caller":"traceutil/trace.go:171","msg":"trace[867886953] transaction","detail":"{read_only:false; response_revision:26423; number_of_response:1; }","duration":"331.448737ms","start":"2026-07-16T07:41:47.000217Z","end":"2026-07-16T07:41:47.331665Z","steps":["trace[867886953] 'process raft request' (duration: 331.290844ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:47.331835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:46.999418Z","time spent":"332.312724ms","remote":"127.0.0.1:49650","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-07-16T07:41:47.332021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:47.000208Z","time spent":"331.687012ms","remote":"127.0.0.1:49650","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-07-16T07:41:47.365381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.378254ms","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-07-16T07:41:47.365407Z","caller":"traceutil/trace.go:171","msg":"trace[891874542] transaction","detail":"{read_only:false; response_revision:26424; number_of_response:1; }","duration":"110.231034ms","start":"2026-07-16T07:41:47.25515Z","end":"2026-07-16T07:41:47.365381Z","steps":["trace[891874542] 'process raft request' (duration: 110.077531ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:47.365477Z","caller":"traceutil/trace.go:171","msg":"trace[577715986] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26423; }","duration":"362.545947ms","start":"2026-07-16T07:41:47.002897Z","end":"2026-07-16T07:41:47.365443Z","steps":["trace[577715986] 'agreement among raft nodes before linearized reading' (duration: 328.863087ms)","trace[577715986] 'range keys from in-memory index tree' (duration: 33.461155ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T07:41:47.365453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.549977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-16T07:41:47.365519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:47.002866Z","time spent":"362.644168ms","remote":"127.0.0.1:49650","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-07-16T07:41:47.365556Z","caller":"traceutil/trace.go:171","msg":"trace[1638404050] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26424; }","duration":"360.68349ms","start":"2026-07-16T07:41:47.00485Z","end":"2026-07-16T07:41:47.365534Z","steps":["trace[1638404050] 'agreement among raft nodes before linearized reading' (duration: 360.527007ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:47.365608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:47.004841Z","time spent":"360.758361ms","remote":"127.0.0.1:49360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-16T07:41:47.365702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.969534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-16T07:41:47.365721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.549466ms","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-07-16T07:41:47.365832Z","caller":"traceutil/trace.go:171","msg":"trace[1111679436] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26424; }","duration":"116.721229ms","start":"2026-07-16T07:41:47.24909Z","end":"2026-07-16T07:41:47.365811Z","steps":["trace[1111679436] 'agreement among raft nodes before linearized reading' (duration: 116.343401ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:47.365806Z","caller":"traceutil/trace.go:171","msg":"trace[1708751452] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26424; }","duration":"117.104696ms","start":"2026-07-16T07:41:47.248684Z","end":"2026-07-16T07:41:47.365788Z","steps":["trace[1708751452] 'agreement among raft nodes before linearized reading' (duration: 116.77974ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:47.365961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.930845ms","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-07-16T07:41:47.366099Z","caller":"traceutil/trace.go:171","msg":"trace[850648515] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26424; }","duration":"114.10853ms","start":"2026-07-16T07:41:47.251968Z","end":"2026-07-16T07:41:47.366077Z","steps":["trace[850648515] 'agreement among raft nodes before linearized reading' (duration: 113.462146ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:47.806319Z","caller":"traceutil/trace.go:171","msg":"trace[560758462] transaction","detail":"{read_only:false; response_revision:26425; number_of_response:1; }","duration":"437.152505ms","start":"2026-07-16T07:41:47.369145Z","end":"2026-07-16T07:41:47.806298Z","steps":["trace[560758462] 'process raft request' (duration: 436.974271ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:47.806452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:47.369123Z","time spent":"437.267027ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T07:41:47.821402Z","caller":"traceutil/trace.go:171","msg":"trace[2067935153] transaction","detail":"{read_only:false; response_revision:26426; number_of_response:1; }","duration":"451.543422ms","start":"2026-07-16T07:41:47.369833Z","end":"2026-07-16T07:41:47.821377Z","steps":["trace[2067935153] 'process raft request' (duration: 451.352418ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:47.821606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:47.36981Z","time spent":"451.666024ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T07:41:47.821769Z","caller":"traceutil/trace.go:171","msg":"trace[923150641] linearizableReadLoop","detail":"{readStateIndex:27295; appliedIndex:27291; }","duration":"217.586853ms","start":"2026-07-16T07:41:47.604151Z","end":"2026-07-16T07:41:47.821738Z","steps":["trace[923150641] 'read index received' (duration: 202.068064ms)","trace[923150641] 'applied index is now lower than readState.Index' (duration: 15.517329ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:41:47.821852Z","caller":"traceutil/trace.go:171","msg":"trace[92006477] transaction","detail":"{read_only:false; response_revision:26427; number_of_response:1; }","duration":"451.684654ms","start":"2026-07-16T07:41:47.370135Z","end":"2026-07-16T07:41:47.82182Z","steps":["trace[92006477] 'process raft request' (duration: 451.196965ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:47.82197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.794266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T07:41:47.821969Z","caller":"traceutil/trace.go:171","msg":"trace[1368378184] transaction","detail":"{read_only:false; response_revision:26428; number_of_response:1; }","duration":"451.295726ms","start":"2026-07-16T07:41:47.370586Z","end":"2026-07-16T07:41:47.821882Z","steps":["trace[1368378184] 'process raft request' (duration: 450.997561ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:47.822053Z","caller":"traceutil/trace.go:171","msg":"trace[620509838] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:26428; }","duration":"217.9315ms","start":"2026-07-16T07:41:47.604103Z","end":"2026-07-16T07:41:47.822034Z","steps":["trace[620509838] 'agreement among raft nodes before linearized reading' (duration: 217.757387ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:47.82207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:47.370125Z","time spent":"451.822957ms","remote":"127.0.0.1:49650","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-07-16T07:41:47.822151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:47.370569Z","time spent":"451.500761ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T07:41:48.064079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.149123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T07:41:48.064146Z","caller":"traceutil/trace.go:171","msg":"trace[359955396] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:26428; }","duration":"137.264195ms","start":"2026-07-16T07:41:47.926864Z","end":"2026-07-16T07:41:48.064128Z","steps":["trace[359955396] 'count revisions from in-memory index tree' (duration: 137.018881ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:48.142809Z","caller":"traceutil/trace.go:171","msg":"trace[2096153732] linearizableReadLoop","detail":"{readStateIndex:27296; appliedIndex:27295; }","duration":"113.044169ms","start":"2026-07-16T07:41:48.029745Z","end":"2026-07-16T07:41:48.142789Z","steps":["trace[2096153732] 'read index received' (duration: 112.842495ms)","trace[2096153732] 'applied index is now lower than readState.Index' (duration: 200.424µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:41:48.142907Z","caller":"traceutil/trace.go:171","msg":"trace[1556135534] transaction","detail":"{read_only:false; response_revision:26429; number_of_response:1; }","duration":"133.725837ms","start":"2026-07-16T07:41:48.009168Z","end":"2026-07-16T07:41:48.142893Z","steps":["trace[1556135534] 'process raft request' (duration: 133.476032ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:48.14302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.259593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-07-16T07:41:48.143052Z","caller":"traceutil/trace.go:171","msg":"trace[1106027734] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26429; }","duration":"113.349115ms","start":"2026-07-16T07:41:48.029695Z","end":"2026-07-16T07:41:48.143044Z","steps":["trace[1106027734] 'agreement among raft nodes before linearized reading' (duration: 113.196532ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:48.143109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.14898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/auth-system/keycloak\" ","response":"range_response_count:1 size:906"} {"level":"info","ts":"2026-07-16T07:41:48.143193Z","caller":"traceutil/trace.go:171","msg":"trace[1890710605] range","detail":"{range_begin:/registry/serviceaccounts/auth-system/keycloak; range_end:; response_count:1; response_revision:26429; }","duration":"113.289314ms","start":"2026-07-16T07:41:48.029877Z","end":"2026-07-16T07:41:48.143167Z","steps":["trace[1890710605] 'agreement among raft nodes before linearized reading' (duration: 113.05941ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:48.143112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.755837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T07:41:48.143242Z","caller":"traceutil/trace.go:171","msg":"trace[514404300] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:26429; }","duration":"107.90852ms","start":"2026-07-16T07:41:48.035319Z","end":"2026-07-16T07:41:48.143228Z","steps":["trace[514404300] 'agreement among raft nodes before linearized reading' (duration: 107.644565ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:48.842626Z","caller":"traceutil/trace.go:171","msg":"trace[1523362750] transaction","detail":"{read_only:false; response_revision:26431; number_of_response:1; }","duration":"225.117129ms","start":"2026-07-16T07:41:48.617472Z","end":"2026-07-16T07:41:48.842589Z","steps":["trace[1523362750] 'process raft request' (duration: 224.889234ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:53.554922Z","caller":"traceutil/trace.go:171","msg":"trace[627513028] transaction","detail":"{read_only:false; response_revision:26463; number_of_response:1; }","duration":"205.913948ms","start":"2026-07-16T07:41:53.348981Z","end":"2026-07-16T07:41:53.554895Z","steps":["trace[627513028] 'process raft request' (duration: 205.50852ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:53.673939Z","caller":"traceutil/trace.go:171","msg":"trace[153213188] linearizableReadLoop","detail":"{readStateIndex:27336; appliedIndex:27330; }","duration":"300.418578ms","start":"2026-07-16T07:41:53.373458Z","end":"2026-07-16T07:41:53.673877Z","steps":["trace[153213188] 'read index received' (duration: 181.307614ms)","trace[153213188] 'applied index is now lower than readState.Index' (duration: 119.109314ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:41:53.674069Z","caller":"traceutil/trace.go:171","msg":"trace[794948961] transaction","detail":"{read_only:false; response_revision:26467; number_of_response:1; }","duration":"315.510589ms","start":"2026-07-16T07:41:53.358547Z","end":"2026-07-16T07:41:53.674057Z","steps":["trace[794948961] 'process raft request' (duration: 315.183063ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:53.674098Z","caller":"traceutil/trace.go:171","msg":"trace[1102266360] transaction","detail":"{read_only:false; response_revision:26466; number_of_response:1; }","duration":"315.516259ms","start":"2026-07-16T07:41:53.358523Z","end":"2026-07-16T07:41:53.674039Z","steps":["trace[1102266360] 'process raft request' (duration: 315.165263ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:53.674237Z","caller":"traceutil/trace.go:171","msg":"trace[1880733061] transaction","detail":"{read_only:false; response_revision:26468; number_of_response:1; }","duration":"315.03088ms","start":"2026-07-16T07:41:53.359198Z","end":"2026-07-16T07:41:53.674229Z","steps":["trace[1880733061] 'process raft request' (duration: 314.571451ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:53.674319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:53.359173Z","time spent":"315.097452ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T07:41:53.674375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:53.358501Z","time spent":"315.725703ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T07:41:53.675649Z","caller":"traceutil/trace.go:171","msg":"trace[228989167] transaction","detail":"{read_only:false; response_revision:26465; number_of_response:1; }","duration":"317.249483ms","start":"2026-07-16T07:41:53.356969Z","end":"2026-07-16T07:41:53.674218Z","steps":["trace[228989167] 'process raft request' (duration: 316.663632ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:53.675763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.714406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"warn","ts":"2026-07-16T07:41:53.675613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.844473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/applicationcredentials/\" range_end:\"/registry/openstack.k-orc.cloud/applicationcredentials0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T07:41:53.675923Z","caller":"traceutil/trace.go:171","msg":"trace[1319800392] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:26469; }","duration":"216.900351ms","start":"2026-07-16T07:41:53.458961Z","end":"2026-07-16T07:41:53.675861Z","steps":["trace[1319800392] 'agreement among raft nodes before linearized reading' (duration: 215.199978ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:53.675972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.51802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T07:41:53.676058Z","caller":"traceutil/trace.go:171","msg":"trace[113012176] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26469; }","duration":"302.606131ms","start":"2026-07-16T07:41:53.373415Z","end":"2026-07-16T07:41:53.676021Z","steps":["trace[113012176] 'agreement among raft nodes before linearized reading' (duration: 300.738175ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:53.675961Z","caller":"traceutil/trace.go:171","msg":"trace[2061017473] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/applicationcredentials/; range_end:/registry/openstack.k-orc.cloud/applicationcredentials0; response_count:0; response_revision:26469; }","duration":"197.2068ms","start":"2026-07-16T07:41:53.478705Z","end":"2026-07-16T07:41:53.675912Z","steps":["trace[2061017473] 'agreement among raft nodes before linearized reading' (duration: 195.472266ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:53.67617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:53.358529Z","time spent":"315.568951ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T07:41:53.675957Z","caller":"traceutil/trace.go:171","msg":"trace[214829802] transaction","detail":"{read_only:false; response_revision:26469; number_of_response:1; }","duration":"289.304734ms","start":"2026-07-16T07:41:53.384944Z","end":"2026-07-16T07:41:53.674249Z","steps":["trace[214829802] 'process raft request' (duration: 288.860766ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:53.675802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:53.35695Z","time spent":"318.793554ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T07:41:53.676424Z","caller":"traceutil/trace.go:171","msg":"trace[1111676150] transaction","detail":"{read_only:false; response_revision:26464; number_of_response:1; }","duration":"319.996986ms","start":"2026-07-16T07:41:53.354218Z","end":"2026-07-16T07:41:53.674215Z","steps":["trace[1111676150] 'process raft request' (duration: 234.58674ms)","trace[1111676150] 'compare' (duration: 84.663202ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T07:41:53.67658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:53.354193Z","time spent":"322.317471ms","remote":"127.0.0.1:49650","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-07-16T07:41:53.676205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:53.373401Z","time spent":"302.692972ms","remote":"127.0.0.1:49844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":30,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-07-16T07:41:54.045786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.237106ms","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-07-16T07:41:54.045855Z","caller":"traceutil/trace.go:171","msg":"trace[1753769452] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26469; }","duration":"218.352818ms","start":"2026-07-16T07:41:53.827487Z","end":"2026-07-16T07:41:54.04584Z","steps":["trace[1753769452] 'range keys from in-memory index tree' (duration: 218.055482ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:54.045971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.922991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-16T07:41:54.046089Z","caller":"traceutil/trace.go:171","msg":"trace[559928047] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26469; }","duration":"202.089964ms","start":"2026-07-16T07:41:53.84397Z","end":"2026-07-16T07:41:54.04606Z","steps":["trace[559928047] 'range keys from in-memory index tree' (duration: 201.630686ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:54.046363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.635952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-07-16T07:41:54.046443Z","caller":"traceutil/trace.go:171","msg":"trace[315309437] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26469; }","duration":"192.767435ms","start":"2026-07-16T07:41:53.853656Z","end":"2026-07-16T07:41:54.046424Z","steps":["trace[315309437] 'range keys from in-memory index tree' (duration: 191.98496ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:54.046666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.168823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-07-16T07:41:54.046791Z","caller":"traceutil/trace.go:171","msg":"trace[348218748] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26469; }","duration":"192.326805ms","start":"2026-07-16T07:41:53.854439Z","end":"2026-07-16T07:41:54.046765Z","steps":["trace[348218748] 'range keys from in-memory index tree' (duration: 191.333377ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:54.653514Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313097249751357555,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-16T07:41:54.791194Z","caller":"traceutil/trace.go:171","msg":"trace[1922959968] transaction","detail":"{read_only:false; response_revision:26470; number_of_response:1; }","duration":"740.406838ms","start":"2026-07-16T07:41:54.050758Z","end":"2026-07-16T07:41:54.791165Z","steps":["trace[1922959968] 'process raft request' (duration: 740.198104ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:54.791488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:54.050705Z","time spent":"740.561041ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T07:41:55.095119Z","caller":"traceutil/trace.go:171","msg":"trace[29873053] transaction","detail":"{read_only:false; response_revision:26471; number_of_response:1; }","duration":"1.043120872s","start":"2026-07-16T07:41:54.051976Z","end":"2026-07-16T07:41:55.095097Z","steps":["trace[29873053] 'process raft request' (duration: 1.042908607s)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:55.095362Z","caller":"traceutil/trace.go:171","msg":"trace[1299608199] transaction","detail":"{read_only:false; response_revision:26472; number_of_response:1; }","duration":"1.040461872s","start":"2026-07-16T07:41:54.054865Z","end":"2026-07-16T07:41:55.095326Z","steps":["trace[1299608199] 'process raft request' (duration: 1.040194517s)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:55.095517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:54.054842Z","time spent":"1.040580943s","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T07:41:55.09611Z","caller":"traceutil/trace.go:171","msg":"trace[1074836830] transaction","detail":"{read_only:false; response_revision:26473; number_of_response:1; }","duration":"1.040524332s","start":"2026-07-16T07:41:54.055573Z","end":"2026-07-16T07:41:55.096097Z","steps":["trace[1074836830] 'process raft request' (duration: 1.039699777s)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:55.096165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:54.055565Z","time spent":"1.040569463s","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T07:41:55.096482Z","caller":"traceutil/trace.go:171","msg":"trace[1691647797] transaction","detail":"{read_only:false; response_revision:26474; number_of_response:1; }","duration":"932.805826ms","start":"2026-07-16T07:41:54.163661Z","end":"2026-07-16T07:41:55.096467Z","steps":["trace[1691647797] 'process raft request' (duration: 932.378838ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:55.096512Z","caller":"traceutil/trace.go:171","msg":"trace[1232479728] transaction","detail":"{read_only:false; response_revision:26475; number_of_response:1; }","duration":"898.496915ms","start":"2026-07-16T07:41:54.198001Z","end":"2026-07-16T07:41:55.096498Z","steps":["trace[1232479728] 'process raft request' (duration: 898.404283ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:55.096549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:54.16364Z","time spent":"932.874147ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T07:41:55.096591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:54.197976Z","time spent":"898.559596ms","remote":"127.0.0.1:49650","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-07-16T07:41:55.096657Z","caller":"traceutil/trace.go:171","msg":"trace[1639912225] linearizableReadLoop","detail":"{readStateIndex:27343; appliedIndex:27337; }","duration":"943.39086ms","start":"2026-07-16T07:41:54.153223Z","end":"2026-07-16T07:41:55.096614Z","steps":["trace[1639912225] 'read index received' (duration: 637.865612ms)","trace[1639912225] 'applied index is now lower than readState.Index' (duration: 305.523178ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T07:41:55.096753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"943.522092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T07:41:55.096785Z","caller":"traceutil/trace.go:171","msg":"trace[602209787] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:26475; }","duration":"943.586844ms","start":"2026-07-16T07:41:54.153188Z","end":"2026-07-16T07:41:55.096775Z","steps":["trace[602209787] 'agreement among raft nodes before linearized reading' (duration: 943.521443ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:55.096811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:54.153169Z","time spent":"943.634004ms","remote":"127.0.0.1:40596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-16T07:41:55.097455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.956341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T07:41:55.097491Z","caller":"traceutil/trace.go:171","msg":"trace[827370582] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeaturerules/; range_end:/registry/nfd.k8s-sigs.io/nodefeaturerules0; response_count:0; response_revision:26475; }","duration":"682.042463ms","start":"2026-07-16T07:41:54.415436Z","end":"2026-07-16T07:41:55.097479Z","steps":["trace[827370582] 'agreement among raft nodes before linearized reading' (duration: 681.979142ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:55.097518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:54.415399Z","time spent":"682.111074ms","remote":"127.0.0.1:42316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":0,"response size":30,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true "} {"level":"warn","ts":"2026-07-16T07:41:55.097783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.500261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/magnum-api-5fcffcd8fd-7v275.18c2b53fa1141ab1\" ","response":"range_response_count:1 size:890"} {"level":"info","ts":"2026-07-16T07:41:55.097818Z","caller":"traceutil/trace.go:171","msg":"trace[1950616069] range","detail":"{range_begin:/registry/events/openstack/magnum-api-5fcffcd8fd-7v275.18c2b53fa1141ab1; range_end:; response_count:1; response_revision:26475; }","duration":"148.577994ms","start":"2026-07-16T07:41:54.94923Z","end":"2026-07-16T07:41:55.097808Z","steps":["trace[1950616069] 'agreement among raft nodes before linearized reading' (duration: 148.436281ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:55.098087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.463397ms","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-07-16T07:41:55.098153Z","caller":"traceutil/trace.go:171","msg":"trace[828695662] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26475; }","duration":"223.62717ms","start":"2026-07-16T07:41:54.874511Z","end":"2026-07-16T07:41:55.098138Z","steps":["trace[828695662] 'agreement among raft nodes before linearized reading' (duration: 223.376515ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:55.098269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.435818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/magnum-conductor-0\" ","response":"range_response_count:1 size:10440"} {"level":"info","ts":"2026-07-16T07:41:55.098376Z","caller":"traceutil/trace.go:171","msg":"trace[1035161142] range","detail":"{range_begin:/registry/pods/openstack/magnum-conductor-0; range_end:; response_count:1; response_revision:26475; }","duration":"151.609222ms","start":"2026-07-16T07:41:54.946742Z","end":"2026-07-16T07:41:55.098351Z","steps":["trace[1035161142] 'agreement among raft nodes before linearized reading' (duration: 151.263715ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:41:55.098693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:54.051963Z","time spent":"1.043222774s","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T07:41:55.211249Z","caller":"traceutil/trace.go:171","msg":"trace[879775885] transaction","detail":"{read_only:false; response_revision:26477; number_of_response:1; }","duration":"108.968651ms","start":"2026-07-16T07:41:55.10225Z","end":"2026-07-16T07:41:55.211219Z","steps":["trace[879775885] 'process raft request' (duration: 108.702516ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:55.212027Z","caller":"traceutil/trace.go:171","msg":"trace[1309075848] transaction","detail":"{read_only:false; response_revision:26478; number_of_response:1; }","duration":"104.649936ms","start":"2026-07-16T07:41:55.107339Z","end":"2026-07-16T07:41:55.211989Z","steps":["trace[1309075848] 'process raft request' (duration: 103.80614ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:41:59.827741Z","caller":"traceutil/trace.go:171","msg":"trace[2083442651] transaction","detail":"{read_only:false; response_revision:26519; number_of_response:1; }","duration":"255.398072ms","start":"2026-07-16T07:41:59.572068Z","end":"2026-07-16T07:41:59.827466Z","steps":["trace[2083442651] 'process raft request' (duration: 255.26754ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:00.044877Z","caller":"traceutil/trace.go:171","msg":"trace[248192643] transaction","detail":"{read_only:false; response_revision:26520; number_of_response:1; }","duration":"471.804961ms","start":"2026-07-16T07:41:59.573044Z","end":"2026-07-16T07:42:00.044848Z","steps":["trace[248192643] 'process raft request' (duration: 458.601938ms)","trace[248192643] 'compare' (duration: 13.0211ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T07:42:00.045035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:59.573025Z","time spent":"471.929983ms","remote":"127.0.0.1:49680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":867,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T07:42:00.045236Z","caller":"traceutil/trace.go:171","msg":"trace[858979091] transaction","detail":"{read_only:false; response_revision:26524; number_of_response:1; }","duration":"337.27213ms","start":"2026-07-16T07:41:59.70794Z","end":"2026-07-16T07:42:00.045212Z","steps":["trace[858979091] 'process raft request' (duration: 337.196289ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:00.045382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:59.707924Z","time spent":"337.381732ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T07:42:00.045403Z","caller":"traceutil/trace.go:171","msg":"trace[552720318] linearizableReadLoop","detail":"{readStateIndex:27396; appliedIndex:27388; }","duration":"214.644486ms","start":"2026-07-16T07:41:59.830719Z","end":"2026-07-16T07:42:00.045363Z","steps":["trace[552720318] 'read index received' (duration: 200.85962ms)","trace[552720318] 'applied index is now lower than readState.Index' (duration: 13.783876ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:42:00.045435Z","caller":"traceutil/trace.go:171","msg":"trace[572873707] transaction","detail":"{read_only:false; response_revision:26522; number_of_response:1; }","duration":"348.70004ms","start":"2026-07-16T07:41:59.696721Z","end":"2026-07-16T07:42:00.045421Z","steps":["trace[572873707] 'process raft request' (duration: 348.292462ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:00.045514Z","caller":"traceutil/trace.go:171","msg":"trace[249430885] transaction","detail":"{read_only:false; response_revision:26525; number_of_response:1; }","duration":"337.473264ms","start":"2026-07-16T07:41:59.708031Z","end":"2026-07-16T07:42:00.045504Z","steps":["trace[249430885] 'process raft request' (duration: 337.144008ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:00.045521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:59.696699Z","time spent":"348.785701ms","remote":"127.0.0.1:49650","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-07-16T07:42:00.045583Z","caller":"traceutil/trace.go:171","msg":"trace[1655291486] transaction","detail":"{read_only:false; response_revision:26523; number_of_response:1; }","duration":"342.841237ms","start":"2026-07-16T07:41:59.702731Z","end":"2026-07-16T07:42:00.045573Z","steps":["trace[1655291486] 'process raft request' (duration: 342.363508ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:00.045599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:59.708022Z","time spent":"337.519284ms","remote":"127.0.0.1:49650","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-07-16T07:42:00.045648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:59.702719Z","time spent":"342.895069ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T07:42:00.045676Z","caller":"traceutil/trace.go:171","msg":"trace[1109620581] transaction","detail":"{read_only:false; response_revision:26521; number_of_response:1; }","duration":"468.924387ms","start":"2026-07-16T07:41:59.57674Z","end":"2026-07-16T07:42:00.045665Z","steps":["trace[1109620581] 'process raft request' (duration: 468.06583ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:00.04574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:59.576727Z","time spent":"468.979448ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T07:42:00.046006Z","caller":"traceutil/trace.go:171","msg":"trace[1591841468] transaction","detail":"{read_only:false; response_revision:26526; number_of_response:1; }","duration":"337.79519ms","start":"2026-07-16T07:41:59.708198Z","end":"2026-07-16T07:42:00.045993Z","steps":["trace[1591841468] 'process raft request' (duration: 337.064296ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:00.046067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:59.708189Z","time spent":"337.847501ms","remote":"127.0.0.1:49650","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-07-16T07:42:00.046079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.358179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/container-infra-registry.18c2b53ffbaafcd2\" ","response":"range_response_count:1 size:722"} {"level":"info","ts":"2026-07-16T07:42:00.046124Z","caller":"traceutil/trace.go:171","msg":"trace[1056706242] range","detail":"{range_begin:/registry/events/openstack/container-infra-registry.18c2b53ffbaafcd2; range_end:; response_count:1; response_revision:26527; }","duration":"215.39752ms","start":"2026-07-16T07:41:59.830713Z","end":"2026-07-16T07:42:00.046111Z","steps":["trace[1056706242] 'agreement among raft nodes before linearized reading' (duration: 215.295158ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:00.046259Z","caller":"traceutil/trace.go:171","msg":"trace[1784024] transaction","detail":"{read_only:false; response_revision:26527; number_of_response:1; }","duration":"337.199388ms","start":"2026-07-16T07:41:59.70905Z","end":"2026-07-16T07:42:00.046249Z","steps":["trace[1784024] 'process raft request' (duration: 336.27067ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:00.0463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:41:59.709038Z","time spent":"337.237618ms","remote":"127.0.0.1:49650","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-07-16T07:42:00.411395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.704558ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-16T07:42:00.411497Z","caller":"traceutil/trace.go:171","msg":"trace[340574708] transaction","detail":"{read_only:false; response_revision:26528; number_of_response:1; }","duration":"363.611007ms","start":"2026-07-16T07:42:00.047868Z","end":"2026-07-16T07:42:00.411479Z","steps":["trace[340574708] 'process raft request' (duration: 232.735276ms)","trace[340574708] 'compare' (duration: 130.547595ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T07:42:00.411546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:42:00.047853Z","time spent":"363.667508ms","remote":"127.0.0.1:49448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T07:42:00.439134Z","caller":"traceutil/trace.go:171","msg":"trace[331622217] linearizableReadLoop","detail":"{readStateIndex:27399; appliedIndex:27398; }","duration":"150.763065ms","start":"2026-07-16T07:42:00.288339Z","end":"2026-07-16T07:42:00.439102Z","steps":["trace[331622217] 'read index received' (duration: 150.671513ms)","trace[331622217] 'applied index is now lower than readState.Index' (duration: 89.702µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:42:00.439176Z","caller":"traceutil/trace.go:171","msg":"trace[898401666] transaction","detail":"{read_only:false; response_revision:26529; number_of_response:1; }","duration":"337.447252ms","start":"2026-07-16T07:42:00.101692Z","end":"2026-07-16T07:42:00.439139Z","steps":["trace[898401666] 'process raft request' (duration: 337.048394ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:00.439216Z","caller":"traceutil/trace.go:171","msg":"trace[2060204121] transaction","detail":"{read_only:false; response_revision:26530; number_of_response:1; }","duration":"279.6693ms","start":"2026-07-16T07:42:00.15951Z","end":"2026-07-16T07:42:00.439179Z","steps":["trace[2060204121] 'process raft request' (duration: 279.513497ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:00.439307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.939338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-16T07:42:00.439342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:42:00.101674Z","time spent":"337.577365ms","remote":"127.0.0.1:49650","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-07-16T07:42:00.439359Z","caller":"traceutil/trace.go:171","msg":"trace[1292113644] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:0; response_revision:26530; }","duration":"151.046551ms","start":"2026-07-16T07:42:00.288295Z","end":"2026-07-16T07:42:00.439342Z","steps":["trace[1292113644] 'agreement among raft nodes before linearized reading' (duration: 150.944679ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:03.356964Z","caller":"traceutil/trace.go:171","msg":"trace[1685847459] transaction","detail":"{read_only:false; response_revision:26621; number_of_response:1; }","duration":"118.575165ms","start":"2026-07-16T07:42:03.238362Z","end":"2026-07-16T07:42:03.356937Z","steps":["trace[1685847459] 'process raft request' (duration: 118.28578ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:03.358015Z","caller":"traceutil/trace.go:171","msg":"trace[1834564907] transaction","detail":"{read_only:false; response_revision:26622; number_of_response:1; }","duration":"116.26652ms","start":"2026-07-16T07:42:03.24173Z","end":"2026-07-16T07:42:03.357997Z","steps":["trace[1834564907] 'process raft request' (duration: 115.978445ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:08.341669Z","caller":"traceutil/trace.go:171","msg":"trace[648378601] transaction","detail":"{read_only:false; response_revision:26674; number_of_response:1; }","duration":"263.819354ms","start":"2026-07-16T07:42:08.077827Z","end":"2026-07-16T07:42:08.341646Z","steps":["trace[648378601] 'process raft request' (duration: 263.634881ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:08.341972Z","caller":"traceutil/trace.go:171","msg":"trace[577330627] transaction","detail":"{read_only:false; response_revision:26675; number_of_response:1; }","duration":"264.020497ms","start":"2026-07-16T07:42:08.077839Z","end":"2026-07-16T07:42:08.34186Z","steps":["trace[577330627] 'process raft request' (duration: 263.762822ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:08.570217Z","caller":"traceutil/trace.go:171","msg":"trace[844368681] transaction","detail":"{read_only:false; response_revision:26678; number_of_response:1; }","duration":"489.807378ms","start":"2026-07-16T07:42:08.080375Z","end":"2026-07-16T07:42:08.570183Z","steps":["trace[844368681] 'process raft request' (duration: 489.710406ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:08.570323Z","caller":"traceutil/trace.go:171","msg":"trace[659297557] transaction","detail":"{read_only:false; response_revision:26677; number_of_response:1; }","duration":"490.010232ms","start":"2026-07-16T07:42:08.08027Z","end":"2026-07-16T07:42:08.57028Z","steps":["trace[659297557] 'process raft request' (duration: 489.767798ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:08.570326Z","caller":"traceutil/trace.go:171","msg":"trace[1648372314] transaction","detail":"{read_only:false; response_revision:26676; number_of_response:1; }","duration":"492.332868ms","start":"2026-07-16T07:42:08.077931Z","end":"2026-07-16T07:42:08.570264Z","steps":["trace[1648372314] 'process raft request' (duration: 491.875249ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:08.570387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:42:08.080368Z","time spent":"489.935552ms","remote":"127.0.0.1:49650","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-07-16T07:42:08.570551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:42:08.080254Z","time spent":"490.173826ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T07:42:08.57055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:42:08.077856Z","time spent":"492.571272ms","remote":"127.0.0.1:49650","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-07-16T07:42:08.570664Z","caller":"traceutil/trace.go:171","msg":"trace[291370175] transaction","detail":"{read_only:false; response_revision:26679; number_of_response:1; }","duration":"490.148925ms","start":"2026-07-16T07:42:08.080436Z","end":"2026-07-16T07:42:08.570585Z","steps":["trace[291370175] 'process raft request' (duration: 489.694736ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:08.570742Z","caller":"traceutil/trace.go:171","msg":"trace[1014225076] transaction","detail":"{read_only:false; response_revision:26680; number_of_response:1; }","duration":"489.213258ms","start":"2026-07-16T07:42:08.081515Z","end":"2026-07-16T07:42:08.570728Z","steps":["trace[1014225076] 'process raft request' (duration: 489.022074ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:08.570802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:42:08.081501Z","time spent":"489.269608ms","remote":"127.0.0.1:49650","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-07-16T07:42:08.570839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:42:08.080429Z","time spent":"490.316688ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T07:42:08.570796Z","caller":"traceutil/trace.go:171","msg":"trace[779343125] linearizableReadLoop","detail":"{readStateIndex:27552; appliedIndex:27545; }","duration":"338.609115ms","start":"2026-07-16T07:42:08.232109Z","end":"2026-07-16T07:42:08.570719Z","steps":["trace[779343125] 'read index received' (duration: 109.403749ms)","trace[779343125] 'applied index is now lower than readState.Index' (duration: 229.203756ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T07:42:08.571028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.894261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T07:42:08.571059Z","caller":"traceutil/trace.go:171","msg":"trace[287593176] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:26680; }","duration":"338.954162ms","start":"2026-07-16T07:42:08.232095Z","end":"2026-07-16T07:42:08.571049Z","steps":["trace[287593176] 'agreement among raft nodes before linearized reading' (duration: 338.87365ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:08.57106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.817667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-16T07:42:08.57107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.186414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-16T07:42:08.571091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:42:08.232022Z","time spent":"339.061223ms","remote":"127.0.0.1:38604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":30,"request content":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true "} {"level":"info","ts":"2026-07-16T07:42:08.571115Z","caller":"traceutil/trace.go:171","msg":"trace[1429644851] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0; response_count:0; response_revision:26680; }","duration":"246.281676ms","start":"2026-07-16T07:42:08.324821Z","end":"2026-07-16T07:42:08.571102Z","steps":["trace[1429644851] 'agreement among raft nodes before linearized reading' (duration: 246.166014ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:08.571114Z","caller":"traceutil/trace.go:171","msg":"trace[1801867469] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:26680; }","duration":"190.904619ms","start":"2026-07-16T07:42:08.380193Z","end":"2026-07-16T07:42:08.571097Z","steps":["trace[1801867469] 'agreement among raft nodes before linearized reading' (duration: 190.797957ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:14.652038Z","caller":"traceutil/trace.go:171","msg":"trace[1151395509] transaction","detail":"{read_only:false; response_revision:26725; number_of_response:1; }","duration":"290.627801ms","start":"2026-07-16T07:42:14.361385Z","end":"2026-07-16T07:42:14.652012Z","steps":["trace[1151395509] 'process raft request' (duration: 290.431117ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:14.83314Z","caller":"traceutil/trace.go:171","msg":"trace[363275649] transaction","detail":"{read_only:false; response_revision:26726; number_of_response:1; }","duration":"242.198507ms","start":"2026-07-16T07:42:14.590916Z","end":"2026-07-16T07:42:14.833114Z","steps":["trace[363275649] 'process raft request' (duration: 241.977163ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:14.833495Z","caller":"traceutil/trace.go:171","msg":"trace[2000270173] transaction","detail":"{read_only:false; response_revision:26727; number_of_response:1; }","duration":"239.374134ms","start":"2026-07-16T07:42:14.594091Z","end":"2026-07-16T07:42:14.833465Z","steps":["trace[2000270173] 'process raft request' (duration: 238.975205ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:14.833515Z","caller":"traceutil/trace.go:171","msg":"trace[898226535] transaction","detail":"{read_only:false; response_revision:26728; number_of_response:1; }","duration":"239.144819ms","start":"2026-07-16T07:42:14.594344Z","end":"2026-07-16T07:42:14.833489Z","steps":["trace[898226535] 'process raft request' (duration: 238.987405ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:14.83379Z","caller":"traceutil/trace.go:171","msg":"trace[747721380] transaction","detail":"{read_only:false; response_revision:26729; number_of_response:1; }","duration":"238.942576ms","start":"2026-07-16T07:42:14.594829Z","end":"2026-07-16T07:42:14.833772Z","steps":["trace[747721380] 'process raft request' (duration: 238.613539ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:14.833889Z","caller":"traceutil/trace.go:171","msg":"trace[1769334236] transaction","detail":"{read_only:false; response_revision:26730; number_of_response:1; }","duration":"238.18975ms","start":"2026-07-16T07:42:14.595646Z","end":"2026-07-16T07:42:14.833836Z","steps":["trace[1769334236] 'process raft request' (duration: 237.925875ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:16.178914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.2665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-07-16T07:42:16.178973Z","caller":"traceutil/trace.go:171","msg":"trace[161743992] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:26739; }","duration":"131.378122ms","start":"2026-07-16T07:42:16.047578Z","end":"2026-07-16T07:42:16.178956Z","steps":["trace[161743992] 'range keys from in-memory index tree' (duration: 131.086326ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:20.816208Z","caller":"traceutil/trace.go:171","msg":"trace[340372079] linearizableReadLoop","detail":"{readStateIndex:27657; appliedIndex:27656; }","duration":"102.502075ms","start":"2026-07-16T07:42:20.713681Z","end":"2026-07-16T07:42:20.816183Z","steps":["trace[340372079] 'read index received' (duration: 102.24261ms)","trace[340372079] 'applied index is now lower than readState.Index' (duration: 250.155µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:42:20.816346Z","caller":"traceutil/trace.go:171","msg":"trace[1564600028] transaction","detail":"{read_only:false; response_revision:26783; number_of_response:1; }","duration":"139.612271ms","start":"2026-07-16T07:42:20.676656Z","end":"2026-07-16T07:42:20.816268Z","steps":["trace[1564600028] 'process raft request' (duration: 139.351776ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:20.816444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.730909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T07:42:20.816509Z","caller":"traceutil/trace.go:171","msg":"trace[1828154009] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachines/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachines0; response_count:0; response_revision:26783; }","duration":"102.819991ms","start":"2026-07-16T07:42:20.713673Z","end":"2026-07-16T07:42:20.816493Z","steps":["trace[1828154009] 'agreement among raft nodes before linearized reading' (duration: 102.656468ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:31.790104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.983405ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-16T07:42:31.790289Z","caller":"traceutil/trace.go:171","msg":"trace[1679013184] linearizableReadLoop","detail":"{readStateIndex:27767; appliedIndex:27766; }","duration":"363.7305ms","start":"2026-07-16T07:42:31.426538Z","end":"2026-07-16T07:42:31.790268Z","steps":["trace[1679013184] 'read index received' (duration: 32.649619ms)","trace[1679013184] 'applied index is now lower than readState.Index' (duration: 331.079591ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:42:31.790556Z","caller":"traceutil/trace.go:171","msg":"trace[931229238] transaction","detail":"{read_only:false; response_revision:26890; number_of_response:1; }","duration":"385.845546ms","start":"2026-07-16T07:42:31.404695Z","end":"2026-07-16T07:42:31.790541Z","steps":["trace[931229238] 'process raft request' (duration: 119.313479ms)","trace[931229238] 'compare' (duration: 265.466256ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T07:42:31.790629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:42:31.404668Z","time spent":"385.925928ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T07:42:31.790916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.395223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-07-16T07:42:31.790956Z","caller":"traceutil/trace.go:171","msg":"trace[1623240302] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26890; }","duration":"364.486504ms","start":"2026-07-16T07:42:31.426459Z","end":"2026-07-16T07:42:31.790946Z","steps":["trace[1623240302] 'agreement among raft nodes before linearized reading' (duration: 364.347382ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:31.790985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:42:31.426433Z","time spent":"364.546325ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-16T07:42:31.791171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.193777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" ","response":"range_response_count:1 size:1312"} {"level":"info","ts":"2026-07-16T07:42:31.791206Z","caller":"traceutil/trace.go:171","msg":"trace[1100601993] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-manila-default-user; range_end:; response_count:1; response_revision:26890; }","duration":"323.271999ms","start":"2026-07-16T07:42:31.467926Z","end":"2026-07-16T07:42:31.791198Z","steps":["trace[1100601993] 'agreement among raft nodes before linearized reading' (duration: 323.176777ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:31.791232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:42:31.467904Z","time spent":"323.322011ms","remote":"127.0.0.1:49472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":1336,"request content":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" "} {"level":"warn","ts":"2026-07-16T07:42:31.791739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.552868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.89\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-07-16T07:42:31.791784Z","caller":"traceutil/trace.go:171","msg":"trace[1636622137] range","detail":"{range_begin:/registry/masterleases/199.204.45.89; range_end:; response_count:1; response_revision:26890; }","duration":"291.64227ms","start":"2026-07-16T07:42:31.50013Z","end":"2026-07-16T07:42:31.791772Z","steps":["trace[1636622137] 'agreement among raft nodes before linearized reading' (duration: 291.546978ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:31.791979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.50259ms","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-07-16T07:42:31.792013Z","caller":"traceutil/trace.go:171","msg":"trace[736242537] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26890; }","duration":"301.56807ms","start":"2026-07-16T07:42:31.490437Z","end":"2026-07-16T07:42:31.792006Z","steps":["trace[736242537] 'agreement among raft nodes before linearized reading' (duration: 301.479519ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:31.792042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T07:42:31.49042Z","time spent":"301.612622ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-16T07:42:33.59268Z","caller":"traceutil/trace.go:171","msg":"trace[1689882098] linearizableReadLoop","detail":"{readStateIndex:27782; appliedIndex:27781; }","duration":"125.861505ms","start":"2026-07-16T07:42:33.466791Z","end":"2026-07-16T07:42:33.592653Z","steps":["trace[1689882098] 'read index received' (duration: 98.61438ms)","trace[1689882098] 'applied index is now lower than readState.Index' (duration: 27.245895ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T07:42:33.592914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.09749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-07-16T07:42:33.59295Z","caller":"traceutil/trace.go:171","msg":"trace[1281367711] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26904; }","duration":"126.200622ms","start":"2026-07-16T07:42:33.466738Z","end":"2026-07-16T07:42:33.592938Z","steps":["trace[1281367711] 'agreement among raft nodes before linearized reading' (duration: 125.996368ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:33.593235Z","caller":"traceutil/trace.go:171","msg":"trace[33530439] transaction","detail":"{read_only:false; response_revision:26904; number_of_response:1; }","duration":"190.404409ms","start":"2026-07-16T07:42:33.402819Z","end":"2026-07-16T07:42:33.593224Z","steps":["trace[33530439] 'process raft request' (duration: 162.582873ms)","trace[33530439] 'compare' (duration: 26.854798ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:42:37.492025Z","caller":"traceutil/trace.go:171","msg":"trace[285882462] transaction","detail":"{read_only:false; response_revision:26934; number_of_response:1; }","duration":"183.040017ms","start":"2026-07-16T07:42:37.308951Z","end":"2026-07-16T07:42:37.491991Z","steps":["trace[285882462] 'process raft request' (duration: 182.643139ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:37.745085Z","caller":"traceutil/trace.go:171","msg":"trace[1449874882] linearizableReadLoop","detail":"{readStateIndex:27814; appliedIndex:27813; }","duration":"103.236539ms","start":"2026-07-16T07:42:37.641827Z","end":"2026-07-16T07:42:37.745064Z","steps":["trace[1449874882] 'read index received' (duration: 103.033255ms)","trace[1449874882] 'applied index is now lower than readState.Index' (duration: 202.044µs)"],"step_count":2} {"level":"warn","ts":"2026-07-16T07:42:37.745253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.419122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-07-16T07:42:37.745293Z","caller":"traceutil/trace.go:171","msg":"trace[767433311] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26935; }","duration":"103.512344ms","start":"2026-07-16T07:42:37.641766Z","end":"2026-07-16T07:42:37.745279Z","steps":["trace[767433311] 'agreement among raft nodes before linearized reading' (duration: 103.385332ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:37.745167Z","caller":"traceutil/trace.go:171","msg":"trace[754479532] transaction","detail":"{read_only:false; response_revision:26935; number_of_response:1; }","duration":"108.93365ms","start":"2026-07-16T07:42:37.636203Z","end":"2026-07-16T07:42:37.745137Z","steps":["trace[754479532] 'process raft request' (duration: 108.713056ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:38.62503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.006424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18431"} {"level":"info","ts":"2026-07-16T07:42:38.625117Z","caller":"traceutil/trace.go:171","msg":"trace[6665780] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:26940; }","duration":"104.370591ms","start":"2026-07-16T07:42:38.520727Z","end":"2026-07-16T07:42:38.625098Z","steps":["trace[6665780] 'range keys from in-memory index tree' (duration: 103.74895ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:38.68724Z","caller":"traceutil/trace.go:171","msg":"trace[1861163691] transaction","detail":"{read_only:false; response_revision:26941; number_of_response:1; }","duration":"127.934386ms","start":"2026-07-16T07:42:38.559275Z","end":"2026-07-16T07:42:38.687209Z","steps":["trace[1861163691] 'process raft request' (duration: 127.746442ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:39.98757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.330346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs/\" range_end:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-16T07:42:39.987621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.012613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-07-16T07:42:39.987654Z","caller":"traceutil/trace.go:171","msg":"trace[2103830571] range","detail":"{range_begin:/registry/runtime.cluster.x-k8s.io/extensionconfigs/; range_end:/registry/runtime.cluster.x-k8s.io/extensionconfigs0; response_count:0; response_revision:26949; }","duration":"180.477709ms","start":"2026-07-16T07:42:39.807156Z","end":"2026-07-16T07:42:39.987634Z","steps":["trace[2103830571] 'count revisions from in-memory index tree' (duration: 180.227303ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:39.987665Z","caller":"traceutil/trace.go:171","msg":"trace[966675905] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26949; }","duration":"189.090244ms","start":"2026-07-16T07:42:39.798558Z","end":"2026-07-16T07:42:39.987648Z","steps":["trace[966675905] 'range keys from in-memory index tree' (duration: 188.791999ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:40.159545Z","caller":"traceutil/trace.go:171","msg":"trace[1421929502] linearizableReadLoop","detail":"{readStateIndex:27832; appliedIndex:27829; }","duration":"157.821851ms","start":"2026-07-16T07:42:40.00169Z","end":"2026-07-16T07:42:40.159512Z","steps":["trace[1421929502] 'read index received' (duration: 29.10904ms)","trace[1421929502] 'applied index is now lower than readState.Index' (duration: 128.711311ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:42:40.159576Z","caller":"traceutil/trace.go:171","msg":"trace[1091948939] transaction","detail":"{read_only:false; response_revision:26951; number_of_response:1; }","duration":"167.699352ms","start":"2026-07-16T07:42:39.991832Z","end":"2026-07-16T07:42:40.159532Z","steps":["trace[1091948939] 'process raft request' (duration: 167.353105ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:40.159612Z","caller":"traceutil/trace.go:171","msg":"trace[1001547232] transaction","detail":"{read_only:false; response_revision:26952; number_of_response:1; }","duration":"167.550289ms","start":"2026-07-16T07:42:39.992017Z","end":"2026-07-16T07:42:40.159567Z","steps":["trace[1001547232] 'process raft request' (duration: 167.392366ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:40.15966Z","caller":"traceutil/trace.go:171","msg":"trace[128400911] transaction","detail":"{read_only:false; response_revision:26953; number_of_response:1; }","duration":"167.514938ms","start":"2026-07-16T07:42:39.992108Z","end":"2026-07-16T07:42:40.159623Z","steps":["trace[128400911] 'process raft request' (duration: 167.355905ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:40.159731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.023305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T07:42:40.159785Z","caller":"traceutil/trace.go:171","msg":"trace[519426825] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26953; }","duration":"158.151718ms","start":"2026-07-16T07:42:40.001621Z","end":"2026-07-16T07:42:40.159773Z","steps":["trace[519426825] 'agreement among raft nodes before linearized reading' (duration: 158.025495ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:41.161433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.573601ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-16T07:42:41.161531Z","caller":"traceutil/trace.go:171","msg":"trace[1941558523] transaction","detail":"{read_only:false; response_revision:26959; number_of_response:1; }","duration":"197.868073ms","start":"2026-07-16T07:42:40.963648Z","end":"2026-07-16T07:42:41.161516Z","steps":["trace[1941558523] 'process raft request' (duration: 87.131109ms)","trace[1941558523] 'compare' (duration: 110.472109ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:42:41.161763Z","caller":"traceutil/trace.go:171","msg":"trace[442279523] transaction","detail":"{read_only:false; response_revision:26960; number_of_response:1; }","duration":"169.890205ms","start":"2026-07-16T07:42:40.991857Z","end":"2026-07-16T07:42:41.161747Z","steps":["trace[442279523] 'process raft request' (duration: 169.750762ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:41.161818Z","caller":"traceutil/trace.go:171","msg":"trace[2003158571] transaction","detail":"{read_only:false; response_revision:26963; number_of_response:1; }","duration":"153.980278ms","start":"2026-07-16T07:42:41.007821Z","end":"2026-07-16T07:42:41.161801Z","steps":["trace[2003158571] 'process raft request' (duration: 153.916686ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:41.161881Z","caller":"traceutil/trace.go:171","msg":"trace[1366254709] linearizableReadLoop","detail":"{readStateIndex:27840; appliedIndex:27837; }","duration":"155.425076ms","start":"2026-07-16T07:42:41.006444Z","end":"2026-07-16T07:42:41.161869Z","steps":["trace[1366254709] 'read index received' (duration: 44.349345ms)","trace[1366254709] 'applied index is now lower than readState.Index' (duration: 111.074571ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T07:42:41.16187Z","caller":"traceutil/trace.go:171","msg":"trace[566998813] transaction","detail":"{read_only:false; response_revision:26961; number_of_response:1; }","duration":"167.64008ms","start":"2026-07-16T07:42:40.994202Z","end":"2026-07-16T07:42:41.161842Z","steps":["trace[566998813] 'process raft request' (duration: 167.489438ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:41.161953Z","caller":"traceutil/trace.go:171","msg":"trace[1862701531] transaction","detail":"{read_only:false; response_revision:26962; number_of_response:1; }","duration":"154.931695ms","start":"2026-07-16T07:42:41.007015Z","end":"2026-07-16T07:42:41.161947Z","steps":["trace[1862701531] 'process raft request' (duration: 154.698331ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T07:42:41.161982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.527618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T07:42:41.162Z","caller":"traceutil/trace.go:171","msg":"trace[1749845402] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26964; }","duration":"155.584529ms","start":"2026-07-16T07:42:41.00641Z","end":"2026-07-16T07:42:41.161995Z","steps":["trace[1749845402] 'agreement among raft nodes before linearized reading' (duration: 155.523538ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:42:41.162063Z","caller":"traceutil/trace.go:171","msg":"trace[1073700546] transaction","detail":"{read_only:false; response_revision:26964; number_of_response:1; }","duration":"154.199831ms","start":"2026-07-16T07:42:41.00785Z","end":"2026-07-16T07:42:41.162049Z","steps":["trace[1073700546] 'process raft request' (duration: 153.916416ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:44:08.282697Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24937} {"level":"info","ts":"2026-07-16T07:44:08.427969Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24937,"took":"140.6171ms","hash":3615467967,"current-db-size-bytes":59736064,"current-db-size":"60 MB","current-db-size-in-use-bytes":36978688,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-07-16T07:44:08.42803Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3615467967,"revision":24937,"compact-revision":21910} {"level":"warn","ts":"2026-07-16T07:46:04.070164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.157963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T07:46:04.070272Z","caller":"traceutil/trace.go:171","msg":"trace[34953214] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:28949; }","duration":"122.305816ms","start":"2026-07-16T07:46:03.947944Z","end":"2026-07-16T07:46:04.07025Z","steps":["trace[34953214] 'range keys from in-memory index tree' (duration: 122.020011ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T07:46:11.533429Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-16T07:46:11.540306Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-07-16T07:46:11.540475Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-07-16T07:49:08.290201Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27866} {"level":"info","ts":"2026-07-16T07:49:08.428265Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27866,"took":"133.93681ms","hash":3344974380,"current-db-size-bytes":59736064,"current-db-size":"60 MB","current-db-size-in-use-bytes":35082240,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-07-16T07:49:08.428334Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3344974380,"revision":27866,"compact-revision":24937} {"level":"info","ts":"2026-07-16T07:54:08.297878Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30546} {"level":"info","ts":"2026-07-16T07:54:08.43353Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30546,"took":"132.471879ms","hash":2539806230,"current-db-size-bytes":59736064,"current-db-size":"60 MB","current-db-size-in-use-bytes":30859264,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-16T07:54:08.433677Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2539806230,"revision":30546,"compact-revision":27866} {"level":"info","ts":"2026-07-16T07:59:08.305139Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32817} {"level":"info","ts":"2026-07-16T07:59:08.470341Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32817,"took":"160.209783ms","hash":1630330880,"current-db-size-bytes":60780544,"current-db-size":"61 MB","current-db-size-in-use-bytes":30425088,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-16T07:59:08.470539Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1630330880,"revision":32817,"compact-revision":30546} {"level":"info","ts":"2026-07-16T08:01:55.954986Z","caller":"traceutil/trace.go:171","msg":"trace[1312699367] transaction","detail":"{read_only:false; response_revision:36443; number_of_response:1; }","duration":"109.450055ms","start":"2026-07-16T08:01:55.845514Z","end":"2026-07-16T08:01:55.954964Z","steps":["trace[1312699367] 'process raft request' (duration: 109.351713ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T08:01:55.955152Z","caller":"traceutil/trace.go:171","msg":"trace[408835182] transaction","detail":"{read_only:false; response_revision:36442; number_of_response:1; }","duration":"109.868744ms","start":"2026-07-16T08:01:55.845273Z","end":"2026-07-16T08:01:55.955142Z","steps":["trace[408835182] 'process raft request' (duration: 46.859792ms)","trace[408835182] 'compare' (duration: 62.624344ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T08:04:08.311282Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35061} {"level":"info","ts":"2026-07-16T08:04:08.460381Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35061,"took":"144.362485ms","hash":600655283,"current-db-size-bytes":60780544,"current-db-size":"61 MB","current-db-size-in-use-bytes":31289344,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-16T08:04:08.460453Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":600655283,"revision":35061,"compact-revision":32817} {"level":"info","ts":"2026-07-16T08:06:59.657527Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-16T08:06:59.663606Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-07-16T08:06:59.663721Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-07-16T08:09:08.318639Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37434} {"level":"info","ts":"2026-07-16T08:09:08.446166Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37434,"took":"123.694531ms","hash":1076803428,"current-db-size-bytes":60780544,"current-db-size":"61 MB","current-db-size-in-use-bytes":31014912,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-16T08:09:08.446261Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1076803428,"revision":37434,"compact-revision":35061}