{"level":"warn","ts":"2026-10-19T01:49:04.642655Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-19T01:49:04.642815Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.108:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.108:2380","--initial-cluster=instance=https://162.253.55.108:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.108:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.108:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-10-19T01:49:04.642917Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-19T01:49:04.64294Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.108:2380"]} {"level":"info","ts":"2026-10-19T01:49:04.642975Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-19T01:49:04.64399Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.108:2379"]} {"level":"info","ts":"2026-10-19T01:49:04.644154Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.108:2380"],"listen-peer-urls":["https://162.253.55.108:2380"],"advertise-client-urls":["https://162.253.55.108:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.108:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.108:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-10-19T01:49:04.650513Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.950283ms"} {"level":"info","ts":"2026-10-19T01:49:04.658996Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"806c7300a47a7256","cluster-id":"5fa6fbb9053710a8"} {"level":"info","ts":"2026-10-19T01:49:04.659115Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 switched to configuration voters=()"} {"level":"info","ts":"2026-10-19T01:49:04.659152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 became follower at term 0"} {"level":"info","ts":"2026-10-19T01:49:04.659175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 806c7300a47a7256 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-19T01:49:04.659192Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 became follower at term 1"} {"level":"info","ts":"2026-10-19T01:49:04.659244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 switched to configuration voters=(9253897780936208982)"} {"level":"warn","ts":"2026-10-19T01:49:04.667835Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-19T01:49:04.669685Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-19T01:49:04.671139Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-10-19T01:49:04.673957Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"806c7300a47a7256","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-19T01:49:04.674264Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"806c7300a47a7256","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-19T01:49:04.674466Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-19T01:49:04.674625Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-19T01:49:04.674667Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-19T01:49:04.675276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 switched to configuration voters=(9253897780936208982)"} {"level":"info","ts":"2026-10-19T01:49:04.676162Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5fa6fbb9053710a8","local-member-id":"806c7300a47a7256","added-peer-id":"806c7300a47a7256","added-peer-peer-urls":["https://162.253.55.108:2380"]} {"level":"info","ts":"2026-10-19T01:49:04.68146Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-19T01:49:04.68183Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"806c7300a47a7256","initial-advertise-peer-urls":["https://162.253.55.108:2380"],"listen-peer-urls":["https://162.253.55.108:2380"],"advertise-client-urls":["https://162.253.55.108:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.108:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-19T01:49:04.681872Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-19T01:49:04.682005Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.108:2380"} {"level":"info","ts":"2026-10-19T01:49:04.68213Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.108:2380"} {"level":"info","ts":"2026-10-19T01:49:05.460208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 is starting a new election at term 1"} {"level":"info","ts":"2026-10-19T01:49:05.460328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-19T01:49:05.460389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 received MsgPreVoteResp from 806c7300a47a7256 at term 1"} {"level":"info","ts":"2026-10-19T01:49:05.460416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 became candidate at term 2"} {"level":"info","ts":"2026-10-19T01:49:05.460432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 received MsgVoteResp from 806c7300a47a7256 at term 2"} {"level":"info","ts":"2026-10-19T01:49:05.460452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"806c7300a47a7256 became leader at term 2"} {"level":"info","ts":"2026-10-19T01:49:05.460469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 806c7300a47a7256 elected leader 806c7300a47a7256 at term 2"} {"level":"info","ts":"2026-10-19T01:49:05.461647Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:49:05.462678Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"806c7300a47a7256","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.108:2379]}","request-path":"/0/members/806c7300a47a7256/attributes","cluster-id":"5fa6fbb9053710a8","publish-timeout":"7s"} {"level":"info","ts":"2026-10-19T01:49:05.462694Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-19T01:49:05.462755Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-19T01:49:05.463649Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5fa6fbb9053710a8","local-member-id":"806c7300a47a7256","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:49:05.463797Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:49:05.463836Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:49:05.46387Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-19T01:49:05.463947Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-19T01:49:05.465879Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.108:2379"} {"level":"info","ts":"2026-10-19T01:49:05.466154Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-19T01:49:58.061313Z","caller":"traceutil/trace.go:171","msg":"trace[225236629] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"147.274923ms","start":"2026-10-19T01:49:57.913969Z","end":"2026-10-19T01:49:58.061244Z","steps":["trace[225236629] 'process raft request' (duration: 147.094438ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:49:58.238983Z","caller":"traceutil/trace.go:171","msg":"trace[1556621380] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"157.536806ms","start":"2026-10-19T01:49:58.08127Z","end":"2026-10-19T01:49:58.238807Z","steps":["trace[1556621380] 'process raft request' (duration: 156.866339ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:49:58.62721Z","caller":"traceutil/trace.go:171","msg":"trace[1244441736] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:631; }","duration":"453.198441ms","start":"2026-10-19T01:49:58.17395Z","end":"2026-10-19T01:49:58.627149Z","steps":["trace[1244441736] 'read index received' (duration: 63.422898ms)","trace[1244441736] 'applied index is now lower than readState.Index' (duration: 389.774453ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:49:58.627247Z","caller":"traceutil/trace.go:171","msg":"trace[624217740] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"503.755906ms","start":"2026-10-19T01:49:58.123463Z","end":"2026-10-19T01:49:58.627219Z","steps":["trace[624217740] 'process raft request' (duration: 456.081135ms)","trace[624217740] 'compare' (duration: 47.203039ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:49:58.627457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.501368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-19T01:49:58.62752Z","caller":"traceutil/trace.go:171","msg":"trace[1324615823] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:609; }","duration":"453.633141ms","start":"2026-10-19T01:49:58.173876Z","end":"2026-10-19T01:49:58.627509Z","steps":["trace[1324615823] 'agreement among raft nodes before linearized reading' (duration: 453.453117ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:49:58.627548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:49:58.173851Z","time spent":"453.689353ms","remote":"127.0.0.1:36574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-19T01:49:58.628051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:49:58.123409Z","time spent":"503.908169ms","remote":"127.0.0.1:36432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T01:49:58.773729Z","caller":"traceutil/trace.go:171","msg":"trace[774046502] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:633; }","duration":"146.400629ms","start":"2026-10-19T01:49:58.627299Z","end":"2026-10-19T01:49:58.7737Z","steps":["trace[774046502] 'read index received' (duration: 146.201734ms)","trace[774046502] 'applied index is now lower than readState.Index' (duration: 197.695µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:49:58.773819Z","caller":"traceutil/trace.go:171","msg":"trace[82826410] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"371.147221ms","start":"2026-10-19T01:49:58.402636Z","end":"2026-10-19T01:49:58.773784Z","steps":["trace[82826410] 'process raft request' (duration: 370.887895ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:49:58.774006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.593779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-10-19T01:49:58.773996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:49:58.402602Z","time spent":"371.297365ms","remote":"127.0.0.1:36574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T01:49:58.774104Z","caller":"traceutil/trace.go:171","msg":"trace[1688510507] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:610; }","duration":"372.712522ms","start":"2026-10-19T01:49:58.401338Z","end":"2026-10-19T01:49:58.77405Z","steps":["trace[1688510507] 'agreement among raft nodes before linearized reading' (duration: 372.489067ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:49:58.774174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.587742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-19T01:49:58.774269Z","caller":"traceutil/trace.go:171","msg":"trace[46600626] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:610; }","duration":"321.746757ms","start":"2026-10-19T01:49:58.452506Z","end":"2026-10-19T01:49:58.774253Z","steps":["trace[46600626] 'agreement among raft nodes before linearized reading' (duration: 321.384677ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:49:58.774336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:49:58.401261Z","time spent":"372.919798ms","remote":"127.0.0.1:36574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-19T01:49:58.774327Z","caller":"traceutil/trace.go:171","msg":"trace[938089596] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"142.315005ms","start":"2026-10-19T01:49:58.631982Z","end":"2026-10-19T01:49:58.774297Z","steps":["trace[938089596] 'process raft request' (duration: 142.220101ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:49:58.774351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:49:58.452478Z","time spent":"321.85977ms","remote":"127.0.0.1:36574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-19T01:50:14.365631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.458643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-19T01:50:14.365742Z","caller":"traceutil/trace.go:171","msg":"trace[1218344391] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:777; }","duration":"215.622047ms","start":"2026-10-19T01:50:14.150082Z","end":"2026-10-19T01:50:14.365704Z","steps":["trace[1218344391] 'range keys from in-memory index tree' (duration: 215.255417ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:50:14.472821Z","caller":"traceutil/trace.go:171","msg":"trace[788729847] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"287.643676ms","start":"2026-10-19T01:50:14.185153Z","end":"2026-10-19T01:50:14.472797Z","steps":["trace[788729847] 'process raft request' (duration: 287.497882ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:50:14.487423Z","caller":"traceutil/trace.go:171","msg":"trace[1166371407] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"117.138885ms","start":"2026-10-19T01:50:14.370252Z","end":"2026-10-19T01:50:14.48739Z","steps":["trace[1166371407] 'process raft request' (duration: 116.992241ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:50:43.608746Z","caller":"traceutil/trace.go:171","msg":"trace[169214096] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"103.446671ms","start":"2026-10-19T01:50:43.505274Z","end":"2026-10-19T01:50:43.608721Z","steps":["trace[169214096] 'process raft request' (duration: 103.309677ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:51:29.535865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.267705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-10-19T01:51:29.535957Z","caller":"traceutil/trace.go:171","msg":"trace[6643639] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1833; }","duration":"295.433179ms","start":"2026-10-19T01:51:29.240504Z","end":"2026-10-19T01:51:29.535938Z","steps":["trace[6643639] 'range keys from in-memory index tree' (duration: 295.034439ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:51:29.536462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.091495ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T01:51:29.536553Z","caller":"traceutil/trace.go:171","msg":"trace[1978923152] linearizableReadLoop","detail":"{readStateIndex:1904; appliedIndex:1903; }","duration":"274.789167ms","start":"2026-10-19T01:51:29.261749Z","end":"2026-10-19T01:51:29.536539Z","steps":["trace[1978923152] 'read index received' (duration: 99.29229ms)","trace[1978923152] 'applied index is now lower than readState.Index' (duration: 175.495597ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:51:29.536628Z","caller":"traceutil/trace.go:171","msg":"trace[1784943449] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"282.528177ms","start":"2026-10-19T01:51:29.254083Z","end":"2026-10-19T01:51:29.536611Z","steps":["trace[1784943449] 'process raft request' (duration: 106.982419ms)","trace[1784943449] 'compare' (duration: 174.968722ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:51:29.536748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.992413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-19T01:51:29.536801Z","caller":"traceutil/trace.go:171","msg":"trace[946895094] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1834; }","duration":"275.096435ms","start":"2026-10-19T01:51:29.261691Z","end":"2026-10-19T01:51:29.536788Z","steps":["trace[946895094] 'agreement among raft nodes before linearized reading' (duration: 274.936821ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:51:29.536877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.721118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-19T01:51:29.536961Z","caller":"traceutil/trace.go:171","msg":"trace[1460572787] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1834; }","duration":"264.856001ms","start":"2026-10-19T01:51:29.272086Z","end":"2026-10-19T01:51:29.536942Z","steps":["trace[1460572787] 'agreement among raft nodes before linearized reading' (duration: 264.570714ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:51:29.53717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.033436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5732"} {"level":"info","ts":"2026-10-19T01:51:29.537204Z","caller":"traceutil/trace.go:171","msg":"trace[480412788] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1834; }","duration":"265.085027ms","start":"2026-10-19T01:51:29.272108Z","end":"2026-10-19T01:51:29.537193Z","steps":["trace[480412788] 'agreement among raft nodes before linearized reading' (duration: 264.976265ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:51:29.747872Z","caller":"traceutil/trace.go:171","msg":"trace[540636201] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"207.302476ms","start":"2026-10-19T01:51:29.540535Z","end":"2026-10-19T01:51:29.747838Z","steps":["trace[540636201] 'process raft request' (duration: 154.174086ms)","trace[540636201] 'compare' (duration: 52.904295ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:51:29.748264Z","caller":"traceutil/trace.go:171","msg":"trace[306299857] linearizableReadLoop","detail":"{readStateIndex:1909; appliedIndex:1904; }","duration":"202.589525ms","start":"2026-10-19T01:51:29.545649Z","end":"2026-10-19T01:51:29.748239Z","steps":["trace[306299857] 'read index received' (duration: 10.214543ms)","trace[306299857] 'applied index is now lower than readState.Index' (duration: 192.374061ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:51:29.748367Z","caller":"traceutil/trace.go:171","msg":"trace[582289731] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"205.839449ms","start":"2026-10-19T01:51:29.542441Z","end":"2026-10-19T01:51:29.74828Z","steps":["trace[582289731] 'process raft request' (duration: 205.302245ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:51:29.748411Z","caller":"traceutil/trace.go:171","msg":"trace[2000160748] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"205.12315ms","start":"2026-10-19T01:51:29.543259Z","end":"2026-10-19T01:51:29.748382Z","steps":["trace[2000160748] 'process raft request' (duration: 204.922515ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:51:29.748367Z","caller":"traceutil/trace.go:171","msg":"trace[356129914] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"205.813518ms","start":"2026-10-19T01:51:29.542467Z","end":"2026-10-19T01:51:29.74828Z","steps":["trace[356129914] 'process raft request' (duration: 205.598712ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:51:29.748564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.895093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a4495980-7f4e-4308-a0e9-ccbb4d734deb\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-19T01:51:29.748605Z","caller":"traceutil/trace.go:171","msg":"trace[1932299051] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a4495980-7f4e-4308-a0e9-ccbb4d734deb; range_end:; response_count:1; response_revision:1839; }","duration":"202.984826ms","start":"2026-10-19T01:51:29.545607Z","end":"2026-10-19T01:51:29.748592Z","steps":["trace[1932299051] 'agreement among raft nodes before linearized reading' (duration: 202.795331ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:51:29.748776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.023542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a4495980-7f4e-4308-a0e9-ccbb4d734deb\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-19T01:51:29.748868Z","caller":"traceutil/trace.go:171","msg":"trace[1383635841] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a4495980-7f4e-4308-a0e9-ccbb4d734deb; range_end:; response_count:1; response_revision:1839; }","duration":"161.203177ms","start":"2026-10-19T01:51:29.587646Z","end":"2026-10-19T01:51:29.748849Z","steps":["trace[1383635841] 'agreement among raft nodes before linearized reading' (duration: 160.868799ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:51:29.969452Z","caller":"traceutil/trace.go:171","msg":"trace[1396134806] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"183.683917ms","start":"2026-10-19T01:51:29.785732Z","end":"2026-10-19T01:51:29.969416Z","steps":["trace[1396134806] 'process raft request' (duration: 171.488023ms)","trace[1396134806] 'compare' (duration: 12.05142ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:52:14.034187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.82019ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-19T01:52:19.946205Z","caller":"traceutil/trace.go:171","msg":"trace[1013994649] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"130.046069ms","start":"2026-10-19T01:52:19.816128Z","end":"2026-10-19T01:52:19.946174Z","steps":["trace[1013994649] 'process raft request' (duration: 129.781982ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:53:10.56266Z","caller":"traceutil/trace.go:171","msg":"trace[1835543859] transaction","detail":"{read_only:false; response_revision:2611; number_of_response:1; }","duration":"191.955155ms","start":"2026-10-19T01:53:10.370666Z","end":"2026-10-19T01:53:10.562621Z","steps":["trace[1835543859] 'process raft request' (duration: 182.226934ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:53:10.562706Z","caller":"traceutil/trace.go:171","msg":"trace[1345399231] transaction","detail":"{read_only:false; response_revision:2612; number_of_response:1; }","duration":"189.148733ms","start":"2026-10-19T01:53:10.373529Z","end":"2026-10-19T01:53:10.562678Z","steps":["trace[1345399231] 'process raft request' (duration: 189.03738ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:53:10.562674Z","caller":"traceutil/trace.go:171","msg":"trace[1087401024] linearizableReadLoop","detail":"{readStateIndex:2710; appliedIndex:2708; }","duration":"186.034722ms","start":"2026-10-19T01:53:10.376614Z","end":"2026-10-19T01:53:10.562649Z","steps":["trace[1087401024] 'read index received' (duration: 176.295181ms)","trace[1087401024] 'applied index is now lower than readState.Index' (duration: 9.738451ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:53:10.562865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.235508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-19T01:53:10.562936Z","caller":"traceutil/trace.go:171","msg":"trace[1830761933] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2612; }","duration":"186.377301ms","start":"2026-10-19T01:53:10.376546Z","end":"2026-10-19T01:53:10.562924Z","steps":["trace[1830761933] 'agreement among raft nodes before linearized reading' (duration: 186.180136ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:53:10.563173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.143004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-10-19T01:53:10.563271Z","caller":"traceutil/trace.go:171","msg":"trace[1496058953] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2612; }","duration":"179.277498ms","start":"2026-10-19T01:53:10.383966Z","end":"2026-10-19T01:53:10.563244Z","steps":["trace[1496058953] 'agreement among raft nodes before linearized reading' (duration: 178.989101ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:58:25.818444Z","caller":"traceutil/trace.go:171","msg":"trace[418164946] transaction","detail":"{read_only:false; response_revision:5110; number_of_response:1; }","duration":"144.768801ms","start":"2026-10-19T01:58:25.673653Z","end":"2026-10-19T01:58:25.818422Z","steps":["trace[418164946] 'process raft request' (duration: 144.660968ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:58:25.821444Z","caller":"traceutil/trace.go:171","msg":"trace[2132325795] transaction","detail":"{read_only:false; response_revision:5111; number_of_response:1; }","duration":"140.078501ms","start":"2026-10-19T01:58:25.681337Z","end":"2026-10-19T01:58:25.821415Z","steps":["trace[2132325795] 'process raft request' (duration: 139.971918ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:58:25.821594Z","caller":"traceutil/trace.go:171","msg":"trace[861331698] transaction","detail":"{read_only:false; response_revision:5112; number_of_response:1; }","duration":"107.695059ms","start":"2026-10-19T01:58:25.713882Z","end":"2026-10-19T01:58:25.821577Z","steps":["trace[861331698] 'process raft request' (duration: 107.490493ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:58:27.485924Z","caller":"traceutil/trace.go:171","msg":"trace[1816909228] transaction","detail":"{read_only:false; response_revision:5220; number_of_response:1; }","duration":"108.751856ms","start":"2026-10-19T01:58:27.377153Z","end":"2026-10-19T01:58:27.485905Z","steps":["trace[1816909228] 'process raft request' (duration: 108.643053ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:58:42.090481Z","caller":"traceutil/trace.go:171","msg":"trace[1573055671] linearizableReadLoop","detail":"{readStateIndex:5690; appliedIndex:5686; }","duration":"108.693884ms","start":"2026-10-19T01:58:41.98175Z","end":"2026-10-19T01:58:42.090443Z","steps":["trace[1573055671] 'read index received' (duration: 14.42171ms)","trace[1573055671] 'applied index is now lower than readState.Index' (duration: 94.270754ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:58:42.090654Z","caller":"traceutil/trace.go:171","msg":"trace[355224518] transaction","detail":"{read_only:false; response_revision:5484; number_of_response:1; }","duration":"173.398537ms","start":"2026-10-19T01:58:41.917201Z","end":"2026-10-19T01:58:42.090599Z","steps":["trace[355224518] 'process raft request' (duration: 108.048407ms)","trace[355224518] 'compare' (duration: 65.012741ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:58:42.090878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.075429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-19T01:58:42.090927Z","caller":"traceutil/trace.go:171","msg":"trace[1802560740] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5484; }","duration":"110.187882ms","start":"2026-10-19T01:58:41.980727Z","end":"2026-10-19T01:58:42.090915Z","steps":["trace[1802560740] 'agreement among raft nodes before linearized reading' (duration: 109.942436ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:58:46.408581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.978565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6lcv8\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-10-19T01:58:46.408674Z","caller":"traceutil/trace.go:171","msg":"trace[104850938] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6lcv8; range_end:; response_count:1; response_revision:5527; }","duration":"115.104889ms","start":"2026-10-19T01:58:46.293547Z","end":"2026-10-19T01:58:46.408652Z","steps":["trace[104850938] 'range keys from in-memory index tree' (duration: 114.823112ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:58:51.809882Z","caller":"traceutil/trace.go:171","msg":"trace[1398078284] transaction","detail":"{read_only:false; response_revision:5632; number_of_response:1; }","duration":"159.786797ms","start":"2026-10-19T01:58:51.65004Z","end":"2026-10-19T01:58:51.809827Z","steps":["trace[1398078284] 'process raft request' (duration: 86.737749ms)","trace[1398078284] 'compare' (duration: 72.898704ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:58:58.292632Z","caller":"traceutil/trace.go:171","msg":"trace[1261540526] transaction","detail":"{read_only:false; response_revision:5776; number_of_response:1; }","duration":"106.987971ms","start":"2026-10-19T01:58:58.185607Z","end":"2026-10-19T01:58:58.292595Z","steps":["trace[1261540526] 'process raft request' (duration: 91.077661ms)","trace[1261540526] 'compare' (duration: 15.645653ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:59:05.500548Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2934} {"level":"info","ts":"2026-10-19T01:59:05.615408Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2934,"took":"113.472087ms","hash":262569202,"current-db-size-bytes":57098240,"current-db-size":"57 MB","current-db-size-in-use-bytes":32239616,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-19T01:59:05.615497Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":262569202,"revision":2934,"compact-revision":-1} {"level":"info","ts":"2026-10-19T02:04:05.507643Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5831} {"level":"info","ts":"2026-10-19T02:04:05.610809Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5831,"took":"101.184956ms","hash":3934851889,"current-db-size-bytes":57098240,"current-db-size":"57 MB","current-db-size-in-use-bytes":26009600,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-19T02:04:05.610875Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3934851889,"revision":5831,"compact-revision":2934} {"level":"info","ts":"2026-10-19T02:04:55.297314Z","caller":"traceutil/trace.go:171","msg":"trace[1600244852] linearizableReadLoop","detail":"{readStateIndex:8777; appliedIndex:8776; }","duration":"199.59847ms","start":"2026-10-19T02:04:55.097699Z","end":"2026-10-19T02:04:55.297297Z","steps":["trace[1600244852] 'read index received' (duration: 199.568529ms)","trace[1600244852] 'applied index is now lower than readState.Index' (duration: 29.131µs)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:04:55.297438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.740333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:04:55.297459Z","caller":"traceutil/trace.go:171","msg":"trace[634713137] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:8479; }","duration":"199.816715ms","start":"2026-10-19T02:04:55.097635Z","end":"2026-10-19T02:04:55.297452Z","steps":["trace[634713137] 'agreement among raft nodes before linearized reading' (duration: 199.744203ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:04:55.297421Z","caller":"traceutil/trace.go:171","msg":"trace[1699627021] transaction","detail":"{read_only:false; response_revision:8479; number_of_response:1; }","duration":"256.406006ms","start":"2026-10-19T02:04:55.040984Z","end":"2026-10-19T02:04:55.29739Z","steps":["trace[1699627021] 'process raft request' (duration: 256.218331ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:04:55.415836Z","caller":"traceutil/trace.go:171","msg":"trace[2093930481] linearizableReadLoop","detail":"{readStateIndex:8778; appliedIndex:8777; }","duration":"118.44635ms","start":"2026-10-19T02:04:55.297364Z","end":"2026-10-19T02:04:55.41581Z","steps":["trace[2093930481] 'read index received' (duration: 90.756159ms)","trace[2093930481] 'applied index is now lower than readState.Index' (duration: 27.689351ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:04:55.415905Z","caller":"traceutil/trace.go:171","msg":"trace[1957316507] transaction","detail":"{read_only:false; response_revision:8480; number_of_response:1; }","duration":"171.308174ms","start":"2026-10-19T02:04:55.244567Z","end":"2026-10-19T02:04:55.415875Z","steps":["trace[1957316507] 'process raft request' (duration: 143.644704ms)","trace[1957316507] 'compare' (duration: 27.486456ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:04:55.416046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.901552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-19T02:04:55.416085Z","caller":"traceutil/trace.go:171","msg":"trace[2079509374] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8480; }","duration":"220.008513ms","start":"2026-10-19T02:04:55.196066Z","end":"2026-10-19T02:04:55.416074Z","steps":["trace[2079509374] 'agreement among raft nodes before linearized reading' (duration: 219.844049ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:05:06.425901Z","caller":"traceutil/trace.go:171","msg":"trace[1874807869] transaction","detail":"{read_only:false; response_revision:8534; number_of_response:1; }","duration":"194.317474ms","start":"2026-10-19T02:05:06.231563Z","end":"2026-10-19T02:05:06.42588Z","steps":["trace[1874807869] 'process raft request' (duration: 194.212501ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:05:07.591193Z","caller":"traceutil/trace.go:171","msg":"trace[1377329272] transaction","detail":"{read_only:false; response_revision:8541; number_of_response:1; }","duration":"129.83811ms","start":"2026-10-19T02:05:07.461321Z","end":"2026-10-19T02:05:07.591159Z","steps":["trace[1377329272] 'process raft request' (duration: 129.573813ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:05:07.593062Z","caller":"traceutil/trace.go:171","msg":"trace[412450698] linearizableReadLoop","detail":"{readStateIndex:8843; appliedIndex:8841; }","duration":"116.314084ms","start":"2026-10-19T02:05:07.476687Z","end":"2026-10-19T02:05:07.593001Z","steps":["trace[412450698] 'read index received' (duration: 114.23239ms)","trace[412450698] 'applied index is now lower than readState.Index' (duration: 2.080473ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:05:07.59319Z","caller":"traceutil/trace.go:171","msg":"trace[209707557] transaction","detail":"{read_only:false; response_revision:8542; number_of_response:1; }","duration":"131.200475ms","start":"2026-10-19T02:05:07.461955Z","end":"2026-10-19T02:05:07.593155Z","steps":["trace[209707557] 'process raft request' (duration: 130.884677ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:05:07.593318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.608242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-19T02:05:07.593369Z","caller":"traceutil/trace.go:171","msg":"trace[742222155] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8542; }","duration":"116.715844ms","start":"2026-10-19T02:05:07.476636Z","end":"2026-10-19T02:05:07.593352Z","steps":["trace[742222155] 'agreement among raft nodes before linearized reading' (duration: 116.502799ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:05:35.055969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.002431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-19T02:05:35.05608Z","caller":"traceutil/trace.go:171","msg":"trace[1891529663] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8741; }","duration":"324.159845ms","start":"2026-10-19T02:05:34.731902Z","end":"2026-10-19T02:05:35.056062Z","steps":["trace[1891529663] 'range keys from in-memory index tree' (duration: 323.817027ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:05:35.056116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:05:34.73188Z","time spent":"324.226987ms","remote":"127.0.0.1:36574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-19T02:05:35.056388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.775612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-10-19T02:05:35.056452Z","caller":"traceutil/trace.go:171","msg":"trace[901125961] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8741; }","duration":"197.883006ms","start":"2026-10-19T02:05:34.858551Z","end":"2026-10-19T02:05:35.056434Z","steps":["trace[901125961] 'range keys from in-memory index tree' (duration: 197.622899ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:05:35.056511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.38108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-10-19T02:05:35.056559Z","caller":"traceutil/trace.go:171","msg":"trace[262789869] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:8741; }","duration":"124.460573ms","start":"2026-10-19T02:05:34.932082Z","end":"2026-10-19T02:05:35.056542Z","steps":["trace[262789869] 'range keys from in-memory index tree' (duration: 124.262527ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:05:35.05672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.238393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6lcv8\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-10-19T02:05:35.056764Z","caller":"traceutil/trace.go:171","msg":"trace[1085098817] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6lcv8; range_end:; response_count:1; response_revision:8741; }","duration":"171.308064ms","start":"2026-10-19T02:05:34.885442Z","end":"2026-10-19T02:05:35.05675Z","steps":["trace[1085098817] 'range keys from in-memory index tree' (duration: 171.13258ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:05:35.056835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.921317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-19T02:05:35.057218Z","caller":"traceutil/trace.go:171","msg":"trace[1377674068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8741; }","duration":"306.276876ms","start":"2026-10-19T02:05:34.750875Z","end":"2026-10-19T02:05:35.057152Z","steps":["trace[1377674068] 'range keys from in-memory index tree' (duration: 305.764663ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:05:35.057718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:05:34.750864Z","time spent":"306.394169ms","remote":"127.0.0.1:36574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-19T02:05:49.010799Z","caller":"traceutil/trace.go:171","msg":"trace[1977168202] linearizableReadLoop","detail":"{readStateIndex:9172; appliedIndex:9171; }","duration":"151.490365ms","start":"2026-10-19T02:05:48.859266Z","end":"2026-10-19T02:05:49.010756Z","steps":["trace[1977168202] 'read index received' (duration: 118.102909ms)","trace[1977168202] 'applied index is now lower than readState.Index' (duration: 33.385666ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:05:49.010981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.687431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-19T02:05:49.011052Z","caller":"traceutil/trace.go:171","msg":"trace[362462512] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:8857; }","duration":"151.793373ms","start":"2026-10-19T02:05:48.859242Z","end":"2026-10-19T02:05:49.011035Z","steps":["trace[362462512] 'agreement among raft nodes before linearized reading' (duration: 151.65113ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:05:49.328781Z","caller":"traceutil/trace.go:171","msg":"trace[2037379334] transaction","detail":"{read_only:false; response_revision:8859; number_of_response:1; }","duration":"121.673372ms","start":"2026-10-19T02:05:49.207078Z","end":"2026-10-19T02:05:49.328752Z","steps":["trace[2037379334] 'process raft request' (duration: 121.447176ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:05:49.328961Z","caller":"traceutil/trace.go:171","msg":"trace[627490969] transaction","detail":"{read_only:false; response_revision:8860; number_of_response:1; }","duration":"121.848956ms","start":"2026-10-19T02:05:49.207081Z","end":"2026-10-19T02:05:49.32893Z","steps":["trace[627490969] 'process raft request' (duration: 121.62137ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:05:49.333178Z","caller":"traceutil/trace.go:171","msg":"trace[490444486] linearizableReadLoop","detail":"{readStateIndex:9176; appliedIndex:9173; }","duration":"124.998566ms","start":"2026-10-19T02:05:49.20815Z","end":"2026-10-19T02:05:49.333148Z","steps":["trace[490444486] 'read index received' (duration: 120.400889ms)","trace[490444486] 'applied index is now lower than readState.Index' (duration: 4.596007ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:05:49.333241Z","caller":"traceutil/trace.go:171","msg":"trace[2047378328] transaction","detail":"{read_only:false; response_revision:8861; number_of_response:1; }","duration":"125.670433ms","start":"2026-10-19T02:05:49.207549Z","end":"2026-10-19T02:05:49.33322Z","steps":["trace[2047378328] 'process raft request' (duration: 125.421726ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:05:49.333922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.752436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:229781"} {"level":"info","ts":"2026-10-19T02:05:49.333978Z","caller":"traceutil/trace.go:171","msg":"trace[1831108250] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8861; }","duration":"125.846028ms","start":"2026-10-19T02:05:49.208119Z","end":"2026-10-19T02:05:49.333965Z","steps":["trace[1831108250] 'agreement among raft nodes before linearized reading' (duration: 125.14093ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:06:04.147185Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000245b.wal"} {"level":"info","ts":"2026-10-19T02:07:14.976196Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"806c7300a47a7256","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-19T02:07:14.984784Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-19T02:07:14.984959Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-19T02:09:05.516145Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8015} {"level":"info","ts":"2026-10-19T02:09:05.588777Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8015,"took":"70.534801ms","hash":1817045616,"current-db-size-bytes":57098240,"current-db-size":"57 MB","current-db-size-in-use-bytes":28815360,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-19T02:09:05.588869Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1817045616,"revision":8015,"compact-revision":5831} {"level":"warn","ts":"2026-10-19T02:10:51.420754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.77018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-19T02:10:51.420852Z","caller":"traceutil/trace.go:171","msg":"trace[1071948944] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11499; }","duration":"111.898723ms","start":"2026-10-19T02:10:51.30892Z","end":"2026-10-19T02:10:51.420819Z","steps":["trace[1071948944] 'range keys from in-memory index tree' (duration: 111.594745ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:14:05.523906Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10497} {"level":"info","ts":"2026-10-19T02:14:05.632947Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10497,"took":"106.647027ms","hash":4226676652,"current-db-size-bytes":57098240,"current-db-size":"57 MB","current-db-size-in-use-bytes":27705344,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-19T02:14:05.633036Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4226676652,"revision":10497,"compact-revision":8015} {"level":"warn","ts":"2026-10-19T02:17:19.474579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.296796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-19T02:17:19.47467Z","caller":"traceutil/trace.go:171","msg":"trace[1489403124] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14105; }","duration":"109.4413ms","start":"2026-10-19T02:17:19.365208Z","end":"2026-10-19T02:17:19.474649Z","steps":["trace[1489403124] 'range keys from in-memory index tree' (duration: 109.192603ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:17:20.338408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.526446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:17:20.339172Z","caller":"traceutil/trace.go:171","msg":"trace[2119218865] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14108; }","duration":"307.647839ms","start":"2026-10-19T02:17:20.030843Z","end":"2026-10-19T02:17:20.33849Z","steps":["trace[2119218865] 'range keys from in-memory index tree' (duration: 307.431733ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:17:20.339277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:17:20.030781Z","time spent":"308.46421ms","remote":"127.0.0.1:36320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-19T02:19:05.529281Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12763} {"level":"info","ts":"2026-10-19T02:19:05.620536Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12763,"took":"86.45682ms","hash":4244233018,"current-db-size-bytes":57098240,"current-db-size":"57 MB","current-db-size-in-use-bytes":30035968,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-19T02:19:05.620608Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4244233018,"revision":12763,"compact-revision":10497} {"level":"warn","ts":"2026-10-19T02:19:09.176543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.014868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:19:09.176651Z","caller":"traceutil/trace.go:171","msg":"trace[2137553867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15234; }","duration":"146.168353ms","start":"2026-10-19T02:19:09.030463Z","end":"2026-10-19T02:19:09.176631Z","steps":["trace[2137553867] 'range keys from in-memory index tree' (duration: 145.947267ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:19:09.176775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.73509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-19T02:19:09.176863Z","caller":"traceutil/trace.go:171","msg":"trace[1701004314] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15234; }","duration":"166.899566ms","start":"2026-10-19T02:19:09.009942Z","end":"2026-10-19T02:19:09.176842Z","steps":["trace[1701004314] 'range keys from in-memory index tree' (duration: 166.567877ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:20:02.178875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.755257ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T02:20:02.179004Z","caller":"traceutil/trace.go:171","msg":"trace[23669482] linearizableReadLoop","detail":"{readStateIndex:16101; appliedIndex:16099; }","duration":"148.7711ms","start":"2026-10-19T02:20:02.030218Z","end":"2026-10-19T02:20:02.178989Z","steps":["trace[23669482] 'read index received' (duration: 9.462903ms)","trace[23669482] 'applied index is now lower than readState.Index' (duration: 139.307147ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:20:02.17907Z","caller":"traceutil/trace.go:171","msg":"trace[487128483] transaction","detail":"{read_only:false; response_revision:15570; number_of_response:1; }","duration":"158.635473ms","start":"2026-10-19T02:20:02.020392Z","end":"2026-10-19T02:20:02.179028Z","steps":["trace[487128483] 'process raft request' (duration: 34.65617ms)","trace[487128483] 'compare' (duration: 123.622584ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:20:02.179222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.002695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:20:02.179307Z","caller":"traceutil/trace.go:171","msg":"trace[504403234] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15570; }","duration":"149.144319ms","start":"2026-10-19T02:20:02.030145Z","end":"2026-10-19T02:20:02.179289Z","steps":["trace[504403234] 'agreement among raft nodes before linearized reading' (duration: 149.014135ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:20:02.179576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.270136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-10-19T02:20:02.179643Z","caller":"traceutil/trace.go:171","msg":"trace[1736527391] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:15570; }","duration":"146.364108ms","start":"2026-10-19T02:20:02.03326Z","end":"2026-10-19T02:20:02.179624Z","steps":["trace[1736527391] 'agreement among raft nodes before linearized reading' (duration: 145.983059ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:24:05.535551Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15214} {"level":"info","ts":"2026-10-19T02:24:05.656599Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15214,"took":"116.879029ms","hash":3244542380,"current-db-size-bytes":57098240,"current-db-size":"57 MB","current-db-size-in-use-bytes":31727616,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-19T02:24:05.65668Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3244542380,"revision":15214,"compact-revision":12763} {"level":"info","ts":"2026-10-19T02:27:57.387807Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"806c7300a47a7256","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-19T02:27:57.393972Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-19T02:27:57.39412Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-19T02:29:05.545786Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17438} {"level":"info","ts":"2026-10-19T02:29:05.656896Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17438,"took":"106.493353ms","hash":781871702,"current-db-size-bytes":57098240,"current-db-size":"57 MB","current-db-size-in-use-bytes":34463744,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-19T02:29:05.657393Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":781871702,"revision":17438,"compact-revision":15214} {"level":"warn","ts":"2026-10-19T02:30:23.854381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.100863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-10-19T02:30:23.854381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.403335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-10-19T02:30:23.854471Z","caller":"traceutil/trace.go:171","msg":"trace[1673723607] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20394; }","duration":"159.220996ms","start":"2026-10-19T02:30:23.695225Z","end":"2026-10-19T02:30:23.854446Z","steps":["trace[1673723607] 'range keys from in-memory index tree' (duration: 158.923688ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:30:23.854479Z","caller":"traceutil/trace.go:171","msg":"trace[1251151733] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20394; }","duration":"193.542208ms","start":"2026-10-19T02:30:23.660916Z","end":"2026-10-19T02:30:23.854458Z","steps":["trace[1251151733] 'range keys from in-memory index tree' (duration: 193.257229ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:30:23.985576Z","caller":"traceutil/trace.go:171","msg":"trace[1034975353] transaction","detail":"{read_only:false; response_revision:20395; number_of_response:1; }","duration":"125.979463ms","start":"2026-10-19T02:30:23.859564Z","end":"2026-10-19T02:30:23.985543Z","steps":["trace[1034975353] 'process raft request' (duration: 125.808459ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:30:24.036397Z","caller":"traceutil/trace.go:171","msg":"trace[2085769811] linearizableReadLoop","detail":"{readStateIndex:21085; appliedIndex:21083; }","duration":"127.76685ms","start":"2026-10-19T02:30:23.90861Z","end":"2026-10-19T02:30:24.036377Z","steps":["trace[2085769811] 'read index received' (duration: 76.78004ms)","trace[2085769811] 'applied index is now lower than readState.Index' (duration: 50.98592ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:30:24.036551Z","caller":"traceutil/trace.go:171","msg":"trace[1520715180] transaction","detail":"{read_only:false; response_revision:20396; number_of_response:1; }","duration":"175.812263ms","start":"2026-10-19T02:30:23.860728Z","end":"2026-10-19T02:30:24.036541Z","steps":["trace[1520715180] 'process raft request' (duration: 175.484183ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:30:24.036818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.19626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-19T02:30:24.036892Z","caller":"traceutil/trace.go:171","msg":"trace[1953726362] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20397; }","duration":"128.327064ms","start":"2026-10-19T02:30:23.908549Z","end":"2026-10-19T02:30:24.036876Z","steps":["trace[1953726362] 'agreement among raft nodes before linearized reading' (duration: 128.16083ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:30:24.201525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.324326ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-19T02:30:24.201798Z","caller":"traceutil/trace.go:171","msg":"trace[1164860770] transaction","detail":"{read_only:false; response_revision:20398; number_of_response:1; }","duration":"160.974402ms","start":"2026-10-19T02:30:24.040739Z","end":"2026-10-19T02:30:24.201714Z","steps":["trace[1164860770] 'process raft request' (duration: 19.365847ms)","trace[1164860770] 'compare' (duration: 141.177323ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:30:24.528974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.996264ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-19T02:30:24.529304Z","caller":"traceutil/trace.go:171","msg":"trace[1734468966] linearizableReadLoop","detail":"{readStateIndex:21089; appliedIndex:21088; }","duration":"173.975454ms","start":"2026-10-19T02:30:24.3551Z","end":"2026-10-19T02:30:24.529076Z","steps":["trace[1734468966] 'read index received' (duration: 42.941µs)","trace[1734468966] 'applied index is now lower than readState.Index' (duration: 173.931133ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:30:24.529553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.452118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-19T02:30:24.529598Z","caller":"traceutil/trace.go:171","msg":"trace[1329170348] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:20399; }","duration":"174.54161ms","start":"2026-10-19T02:30:24.355045Z","end":"2026-10-19T02:30:24.529587Z","steps":["trace[1329170348] 'agreement among raft nodes before linearized reading' (duration: 174.310063ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:30:25.157771Z","caller":"traceutil/trace.go:171","msg":"trace[2048429566] transaction","detail":"{read_only:false; response_revision:20400; number_of_response:1; }","duration":"308.666601ms","start":"2026-10-19T02:30:24.849087Z","end":"2026-10-19T02:30:25.157753Z","steps":["trace[2048429566] 'process raft request' (duration: 308.534168ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:30:25.157817Z","caller":"traceutil/trace.go:171","msg":"trace[1659297100] linearizableReadLoop","detail":"{readStateIndex:21090; appliedIndex:21090; }","duration":"126.463225ms","start":"2026-10-19T02:30:25.031323Z","end":"2026-10-19T02:30:25.157786Z","steps":["trace[1659297100] 'read index received' (duration: 126.448755ms)","trace[1659297100] 'applied index is now lower than readState.Index' (duration: 11.92µs)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:30:25.157888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:30:24.849061Z","time spent":"308.767814ms","remote":"127.0.0.1:36574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:30:25.15796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.619569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:30:25.158013Z","caller":"traceutil/trace.go:171","msg":"trace[1619080813] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20400; }","duration":"126.715121ms","start":"2026-10-19T02:30:25.031269Z","end":"2026-10-19T02:30:25.157984Z","steps":["trace[1619080813] 'agreement among raft nodes before linearized reading' (duration: 126.616529ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:30:25.237955Z","caller":"traceutil/trace.go:171","msg":"trace[900922181] transaction","detail":"{read_only:false; response_revision:20401; number_of_response:1; }","duration":"189.576775ms","start":"2026-10-19T02:30:25.048324Z","end":"2026-10-19T02:30:25.237901Z","steps":["trace[900922181] 'process raft request' (duration: 187.471251ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:34:05.555229Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19928} {"level":"info","ts":"2026-10-19T02:34:05.672002Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19928,"took":"112.417373ms","hash":695983408,"current-db-size-bytes":57098240,"current-db-size":"57 MB","current-db-size-in-use-bytes":31891456,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-19T02:34:05.672078Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":695983408,"revision":19928,"compact-revision":17438} {"level":"info","ts":"2026-10-19T02:34:20.255626Z","caller":"traceutil/trace.go:171","msg":"trace[1791847880] transaction","detail":"{read_only:false; response_revision:22827; number_of_response:1; }","duration":"127.517862ms","start":"2026-10-19T02:34:20.128087Z","end":"2026-10-19T02:34:20.255605Z","steps":["trace[1791847880] 'process raft request' (duration: 127.197964ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:34:20.618861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.23909ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-19T02:34:20.618987Z","caller":"traceutil/trace.go:171","msg":"trace[345523501] transaction","detail":"{read_only:false; response_revision:22828; number_of_response:1; }","duration":"345.114204ms","start":"2026-10-19T02:34:20.27385Z","end":"2026-10-19T02:34:20.618964Z","steps":["trace[345523501] 'process raft request' (duration: 193.690119ms)","trace[345523501] 'compare' (duration: 151.126768ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:34:20.619057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:34:20.273823Z","time spent":"345.185416ms","remote":"127.0.0.1:36372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10698,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:34:20.62086Z","caller":"traceutil/trace.go:171","msg":"trace[895549804] transaction","detail":"{read_only:false; response_revision:22829; number_of_response:1; }","duration":"308.491453ms","start":"2026-10-19T02:34:20.312346Z","end":"2026-10-19T02:34:20.620837Z","steps":["trace[895549804] 'process raft request' (duration: 308.263268ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:34:20.620831Z","caller":"traceutil/trace.go:171","msg":"trace[1364653883] linearizableReadLoop","detail":"{readStateIndex:23593; appliedIndex:23590; }","duration":"233.211613ms","start":"2026-10-19T02:34:20.387593Z","end":"2026-10-19T02:34:20.620804Z","steps":["trace[1364653883] 'read index received' (duration: 80.002973ms)","trace[1364653883] 'applied index is now lower than readState.Index' (duration: 153.2076ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:34:20.621082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.499329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-19T02:34:20.621105Z","caller":"traceutil/trace.go:171","msg":"trace[1192906745] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22830; }","duration":"233.554831ms","start":"2026-10-19T02:34:20.387544Z","end":"2026-10-19T02:34:20.621099Z","steps":["trace[1192906745] 'agreement among raft nodes before linearized reading' (duration: 233.447098ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:34:20.620901Z","caller":"traceutil/trace.go:171","msg":"trace[117619758] transaction","detail":"{read_only:false; response_revision:22830; number_of_response:1; }","duration":"243.681231ms","start":"2026-10-19T02:34:20.377196Z","end":"2026-10-19T02:34:20.620877Z","steps":["trace[117619758] 'process raft request' (duration: 243.544268ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:34:20.620941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:34:20.312282Z","time spent":"308.611777ms","remote":"127.0.0.1:36574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:34:30.967622Z","caller":"traceutil/trace.go:171","msg":"trace[949198610] linearizableReadLoop","detail":"{readStateIndex:23702; appliedIndex:23701; }","duration":"115.679828ms","start":"2026-10-19T02:34:30.851918Z","end":"2026-10-19T02:34:30.967598Z","steps":["trace[949198610] 'read index received' (duration: 115.489953ms)","trace[949198610] 'applied index is now lower than readState.Index' (duration: 189.045µs)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:34:30.967837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.897814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-10-19T02:34:30.967874Z","caller":"traceutil/trace.go:171","msg":"trace[1787446562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:22936; }","duration":"115.969386ms","start":"2026-10-19T02:34:30.851895Z","end":"2026-10-19T02:34:30.967864Z","steps":["trace[1787446562] 'agreement among raft nodes before linearized reading' (duration: 115.815572ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:34:30.968232Z","caller":"traceutil/trace.go:171","msg":"trace[418195797] transaction","detail":"{read_only:false; response_revision:22936; number_of_response:1; }","duration":"117.281509ms","start":"2026-10-19T02:34:30.850933Z","end":"2026-10-19T02:34:30.968215Z","steps":["trace[418195797] 'process raft request' (duration: 116.5362ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:37:25.951709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.797095ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-19T02:37:25.951926Z","caller":"traceutil/trace.go:171","msg":"trace[1326946021] transaction","detail":"{read_only:false; response_revision:24743; number_of_response:1; }","duration":"250.2869ms","start":"2026-10-19T02:37:25.701613Z","end":"2026-10-19T02:37:25.9519Z","steps":["trace[1326946021] 'process raft request' (duration: 103.203437ms)","trace[1326946021] 'compare' (duration: 146.116128ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:37:26.035422Z","caller":"traceutil/trace.go:171","msg":"trace[561587084] linearizableReadLoop","detail":"{readStateIndex:25553; appliedIndex:25551; }","duration":"309.158411ms","start":"2026-10-19T02:37:25.72622Z","end":"2026-10-19T02:37:26.035379Z","steps":["trace[561587084] 'read index received' (duration: 78.694419ms)","trace[561587084] 'applied index is now lower than readState.Index' (duration: 230.463032ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:37:26.035679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.423947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/floatingips/\" range_end:\"/registry/openstack.k-orc.cloud/floatingips0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:37:26.035833Z","caller":"traceutil/trace.go:171","msg":"trace[102962448] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/floatingips/; range_end:/registry/openstack.k-orc.cloud/floatingips0; response_count:0; response_revision:24744; }","duration":"309.633632ms","start":"2026-10-19T02:37:25.726173Z","end":"2026-10-19T02:37:26.035807Z","steps":["trace[102962448] 'agreement among raft nodes before linearized reading' (duration: 309.359145ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:37:26.035899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:37:25.726147Z","time spent":"309.733215ms","remote":"127.0.0.1:44362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/floatingips/\" range_end:\"/registry/openstack.k-orc.cloud/floatingips0\" count_only:true "} {"level":"info","ts":"2026-10-19T02:37:26.036391Z","caller":"traceutil/trace.go:171","msg":"trace[1207198930] transaction","detail":"{read_only:false; response_revision:24744; number_of_response:1; }","duration":"315.672248ms","start":"2026-10-19T02:37:25.719795Z","end":"2026-10-19T02:37:26.035468Z","steps":["trace[1207198930] 'process raft request' (duration: 315.422661ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:37:26.036524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:37:25.71977Z","time spent":"316.673875ms","remote":"127.0.0.1:36574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:37:26.249616Z","caller":"traceutil/trace.go:171","msg":"trace[2071639292] transaction","detail":"{read_only:false; response_revision:24745; number_of_response:1; }","duration":"310.31961ms","start":"2026-10-19T02:37:25.93925Z","end":"2026-10-19T02:37:26.249569Z","steps":["trace[2071639292] 'process raft request' (duration: 290.633515ms)","trace[2071639292] 'compare' (duration: 19.4735ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:37:26.249639Z","caller":"traceutil/trace.go:171","msg":"trace[1358900105] linearizableReadLoop","detail":"{readStateIndex:25554; appliedIndex:25553; }","duration":"214.111983ms","start":"2026-10-19T02:37:26.035492Z","end":"2026-10-19T02:37:26.249604Z","steps":["trace[1358900105] 'read index received' (duration: 194.408618ms)","trace[1358900105] 'applied index is now lower than readState.Index' (duration: 19.700025ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:37:26.249761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.847313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-19T02:37:26.249783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.954265ms","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:6"} {"level":"warn","ts":"2026-10-19T02:37:26.249822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:37:25.939218Z","time spent":"310.488995ms","remote":"127.0.0.1:36574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:37:26.249845Z","caller":"traceutil/trace.go:171","msg":"trace[1741259805] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24746; }","duration":"217.002857ms","start":"2026-10-19T02:37:26.032821Z","end":"2026-10-19T02:37:26.249824Z","steps":["trace[1741259805] 'agreement among raft nodes before linearized reading' (duration: 216.835163ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:37:26.249833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.390393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:37:26.249855Z","caller":"traceutil/trace.go:171","msg":"trace[1439590299] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:24746; }","duration":"491.122349ms","start":"2026-10-19T02:37:25.758712Z","end":"2026-10-19T02:37:26.249834Z","steps":["trace[1439590299] 'agreement among raft nodes before linearized reading' (duration: 490.966425ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:37:26.249835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.915831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-19T02:37:26.249909Z","caller":"traceutil/trace.go:171","msg":"trace[1222720776] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:24746; }","duration":"494.517636ms","start":"2026-10-19T02:37:25.75537Z","end":"2026-10-19T02:37:26.249887Z","steps":["trace[1222720776] 'agreement among raft nodes before linearized reading' (duration: 494.390783ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:37:26.249947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.373203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-19T02:37:26.249959Z","caller":"traceutil/trace.go:171","msg":"trace[1388385949] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:24746; }","duration":"434.101406ms","start":"2026-10-19T02:37:25.815828Z","end":"2026-10-19T02:37:26.249929Z","steps":["trace[1388385949] 'agreement among raft nodes before linearized reading' (duration: 433.818818ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:37:26.249997Z","caller":"traceutil/trace.go:171","msg":"trace[172405506] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24746; }","duration":"211.442874ms","start":"2026-10-19T02:37:26.038537Z","end":"2026-10-19T02:37:26.24998Z","steps":["trace[172405506] 'agreement among raft nodes before linearized reading' (duration: 211.27623ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:37:26.250044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:37:25.815805Z","time spent":"434.216409ms","remote":"127.0.0.1:36628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":20,"response size":31,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-10-19T02:37:26.249968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:37:25.755346Z","time spent":"494.606158ms","remote":"127.0.0.1:38210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":128,"response count":0,"response size":29,"request content":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true "} {"level":"warn","ts":"2026-10-19T02:37:26.249911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:37:25.758631Z","time spent":"491.265983ms","remote":"127.0.0.1:52656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-10-19T02:37:26.250875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.717753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-19T02:37:26.250941Z","caller":"traceutil/trace.go:171","msg":"trace[510170599] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24746; }","duration":"206.811436ms","start":"2026-10-19T02:37:26.044113Z","end":"2026-10-19T02:37:26.250924Z","steps":["trace[510170599] 'agreement among raft nodes before linearized reading' (duration: 205.858542ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:37:47.06372Z","caller":"traceutil/trace.go:171","msg":"trace[13909901] linearizableReadLoop","detail":"{readStateIndex:25712; appliedIndex:25711; }","duration":"208.140869ms","start":"2026-10-19T02:37:46.85555Z","end":"2026-10-19T02:37:47.06369Z","steps":["trace[13909901] 'read index received' (duration: 207.868172ms)","trace[13909901] 'applied index is now lower than readState.Index' (duration: 271.387µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:37:47.06377Z","caller":"traceutil/trace.go:171","msg":"trace[516709876] transaction","detail":"{read_only:false; response_revision:24899; number_of_response:1; }","duration":"245.278772ms","start":"2026-10-19T02:37:46.81845Z","end":"2026-10-19T02:37:47.063728Z","steps":["trace[516709876] 'process raft request' (duration: 244.983374ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:37:47.06394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.364686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/servergroups/\" range_end:\"/registry/openstack.k-orc.cloud/servergroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-19T02:37:47.064025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.147271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-19T02:37:47.064107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.298898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2083"} {"level":"info","ts":"2026-10-19T02:37:47.064126Z","caller":"traceutil/trace.go:171","msg":"trace[20995885] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/servergroups/; range_end:/registry/openstack.k-orc.cloud/servergroups0; response_count:0; response_revision:24899; }","duration":"208.560531ms","start":"2026-10-19T02:37:46.855498Z","end":"2026-10-19T02:37:47.064059Z","steps":["trace[20995885] 'agreement among raft nodes before linearized reading' (duration: 208.363376ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:37:47.064207Z","caller":"traceutil/trace.go:171","msg":"trace[915417841] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:24899; }","duration":"101.442502ms","start":"2026-10-19T02:37:46.962743Z","end":"2026-10-19T02:37:47.064186Z","steps":["trace[915417841] 'agreement among raft nodes before linearized reading' (duration: 101.213976ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:37:47.064234Z","caller":"traceutil/trace.go:171","msg":"trace[563655396] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:24899; }","duration":"155.373476ms","start":"2026-10-19T02:37:46.908794Z","end":"2026-10-19T02:37:47.064167Z","steps":["trace[563655396] 'agreement among raft nodes before linearized reading' (duration: 155.146251ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:38:35.814679Z","caller":"traceutil/trace.go:171","msg":"trace[1066199819] transaction","detail":"{read_only:false; response_revision:25357; number_of_response:1; }","duration":"191.042111ms","start":"2026-10-19T02:38:35.623611Z","end":"2026-10-19T02:38:35.814653Z","steps":["trace[1066199819] 'process raft request' (duration: 190.845366ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:38:36.111845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.999331ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-19T02:38:36.112105Z","caller":"traceutil/trace.go:171","msg":"trace[918999457] linearizableReadLoop","detail":"{readStateIndex:26184; appliedIndex:26182; }","duration":"266.25902ms","start":"2026-10-19T02:38:35.845825Z","end":"2026-10-19T02:38:36.112084Z","steps":["trace[918999457] 'read index received' (duration: 56.873339ms)","trace[918999457] 'applied index is now lower than readState.Index' (duration: 209.384601ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:38:36.112214Z","caller":"traceutil/trace.go:171","msg":"trace[1952109944] transaction","detail":"{read_only:false; response_revision:25358; number_of_response:1; }","duration":"356.755151ms","start":"2026-10-19T02:38:35.755442Z","end":"2026-10-19T02:38:36.112197Z","steps":["trace[1952109944] 'process raft request' (duration: 147.296568ms)","trace[1952109944] 'compare' (duration: 208.722855ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:38:36.112319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:38:35.755406Z","time spent":"356.837233ms","remote":"127.0.0.1:36574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:38:36.112367Z","caller":"traceutil/trace.go:171","msg":"trace[1428560262] transaction","detail":"{read_only:false; response_revision:25359; number_of_response:1; }","duration":"346.715224ms","start":"2026-10-19T02:38:35.765613Z","end":"2026-10-19T02:38:36.112328Z","steps":["trace[1428560262] 'process raft request' (duration: 346.350784ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:38:36.112563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.681321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:38:36.112649Z","caller":"traceutil/trace.go:171","msg":"trace[1586910219] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools0; response_count:0; response_revision:25359; }","duration":"266.841725ms","start":"2026-10-19T02:38:35.845785Z","end":"2026-10-19T02:38:36.112627Z","steps":["trace[1586910219] 'agreement among raft nodes before linearized reading' (duration: 266.422384ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:38:36.11348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:38:35.765591Z","time spent":"346.855827ms","remote":"127.0.0.1:36574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:39:05.562405Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22230} {"level":"info","ts":"2026-10-19T02:39:05.689817Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22230,"took":"120.618324ms","hash":3027374173,"current-db-size-bytes":57098240,"current-db-size":"57 MB","current-db-size-in-use-bytes":44871680,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-10-19T02:39:05.689887Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3027374173,"revision":22230,"compact-revision":19928} {"level":"info","ts":"2026-10-19T02:39:13.947304Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000676a.wal"} {"level":"info","ts":"2026-10-19T02:39:27.90591Z","caller":"traceutil/trace.go:171","msg":"trace[264274100] transaction","detail":"{read_only:false; response_revision:25907; number_of_response:1; }","duration":"150.909691ms","start":"2026-10-19T02:39:27.754977Z","end":"2026-10-19T02:39:27.905887Z","steps":["trace[264274100] 'process raft request' (duration: 150.125511ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:42:11.09776Z","caller":"traceutil/trace.go:171","msg":"trace[1922141016] transaction","detail":"{read_only:false; response_revision:27474; number_of_response:1; }","duration":"137.797495ms","start":"2026-10-19T02:42:10.959934Z","end":"2026-10-19T02:42:11.097731Z","steps":["trace[1922141016] 'process raft request' (duration: 137.62371ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:42:12.092801Z","caller":"traceutil/trace.go:171","msg":"trace[1305318652] linearizableReadLoop","detail":"{readStateIndex:28358; appliedIndex:28357; }","duration":"234.543697ms","start":"2026-10-19T02:42:11.858228Z","end":"2026-10-19T02:42:12.092772Z","steps":["trace[1305318652] 'read index received' (duration: 234.443224ms)","trace[1305318652] 'applied index is now lower than readState.Index' (duration: 99.023µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:42:12.092854Z","caller":"traceutil/trace.go:171","msg":"trace[44400766] transaction","detail":"{read_only:false; response_revision:27481; number_of_response:1; }","duration":"235.644605ms","start":"2026-10-19T02:42:11.857177Z","end":"2026-10-19T02:42:12.092821Z","steps":["trace[44400766] 'process raft request' (duration: 235.405899ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:42:12.174722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.463788ms","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-10-19T02:42:12.174945Z","caller":"traceutil/trace.go:171","msg":"trace[1129475226] transaction","detail":"{read_only:false; response_revision:27482; number_of_response:1; }","duration":"271.027782ms","start":"2026-10-19T02:42:11.903887Z","end":"2026-10-19T02:42:12.174915Z","steps":["trace[1129475226] 'process raft request' (duration: 223.461162ms)","trace[1129475226] 'compare' (duration: 47.20021ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:42:12.17573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.4904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-19T02:42:12.175746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.717326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:42:12.175822Z","caller":"traceutil/trace.go:171","msg":"trace[2081044707] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27483; }","duration":"143.643045ms","start":"2026-10-19T02:42:12.032154Z","end":"2026-10-19T02:42:12.175797Z","steps":["trace[2081044707] 'agreement among raft nodes before linearized reading' (duration: 143.45011ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:42:12.175832Z","caller":"traceutil/trace.go:171","msg":"trace[1309340079] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:27483; }","duration":"272.87584ms","start":"2026-10-19T02:42:11.902937Z","end":"2026-10-19T02:42:12.175812Z","steps":["trace[1309340079] 'agreement among raft nodes before linearized reading' (duration: 272.663515ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:42:12.176344Z","caller":"traceutil/trace.go:171","msg":"trace[889599425] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:27481; }","duration":"316.595052ms","start":"2026-10-19T02:42:11.858197Z","end":"2026-10-19T02:42:12.174792Z","steps":["trace[889599425] 'agreement among raft nodes before linearized reading' (duration: 234.708711ms)","trace[889599425] 'range keys from in-memory index tree' (duration: 81.664414ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:42:12.176399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:42:11.858183Z","time spent":"318.197453ms","remote":"127.0.0.1:36574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-19T02:42:12.364392Z","caller":"traceutil/trace.go:171","msg":"trace[1200268569] transaction","detail":"{read_only:false; response_revision:27486; number_of_response:1; }","duration":"122.563785ms","start":"2026-10-19T02:42:12.241797Z","end":"2026-10-19T02:42:12.364361Z","steps":["trace[1200268569] 'process raft request' (duration: 122.34481ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:43:12.654341Z","caller":"traceutil/trace.go:171","msg":"trace[393265484] linearizableReadLoop","detail":"{readStateIndex:28942; appliedIndex:28941; }","duration":"102.365848ms","start":"2026-10-19T02:43:12.551915Z","end":"2026-10-19T02:43:12.654281Z","steps":["trace[393265484] 'read index received' (duration: 91.606552ms)","trace[393265484] 'applied index is now lower than readState.Index' (duration: 10.758296ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:43:12.654462Z","caller":"traceutil/trace.go:171","msg":"trace[52429746] transaction","detail":"{read_only:false; response_revision:28050; number_of_response:1; }","duration":"106.850644ms","start":"2026-10-19T02:43:12.547579Z","end":"2026-10-19T02:43:12.654429Z","steps":["trace[52429746] 'process raft request' (duration: 95.970505ms)","trace[52429746] 'compare' (duration: 10.621903ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:43:12.654511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.614654ms","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":"info","ts":"2026-10-19T02:43:12.65476Z","caller":"traceutil/trace.go:171","msg":"trace[1607616800] 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:28050; }","duration":"102.874071ms","start":"2026-10-19T02:43:12.551867Z","end":"2026-10-19T02:43:12.654741Z","steps":["trace[1607616800] 'agreement among raft nodes before linearized reading' (duration: 102.587854ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:44:05.57304Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25576} {"level":"info","ts":"2026-10-19T02:44:05.751832Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25576,"took":"172.347825ms","hash":533608965,"current-db-size-bytes":59637760,"current-db-size":"60 MB","current-db-size-in-use-bytes":36081664,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-19T02:44:05.7519Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":533608965,"revision":25576,"compact-revision":22230} {"level":"info","ts":"2026-10-19T02:45:28.184804Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"806c7300a47a7256","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-19T02:45:28.191652Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-19T02:45:28.191763Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-19T02:49:05.578429Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28440} {"level":"info","ts":"2026-10-19T02:49:05.727637Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28440,"took":"144.995991ms","hash":591105661,"current-db-size-bytes":59637760,"current-db-size":"60 MB","current-db-size-in-use-bytes":30289920,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-19T02:49:05.727779Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":591105661,"revision":28440,"compact-revision":25576} {"level":"info","ts":"2026-10-19T02:54:05.589522Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30660} {"level":"info","ts":"2026-10-19T02:54:05.728151Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30660,"took":"133.459364ms","hash":2358065199,"current-db-size-bytes":59637760,"current-db-size":"60 MB","current-db-size-in-use-bytes":31072256,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-19T02:54:05.728248Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2358065199,"revision":30660,"compact-revision":28440} {"level":"info","ts":"2026-10-19T02:59:05.598768Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32923} {"level":"info","ts":"2026-10-19T02:59:05.759131Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32923,"took":"156.859204ms","hash":360612605,"current-db-size-bytes":60682240,"current-db-size":"61 MB","current-db-size-in-use-bytes":30863360,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-19T02:59:05.759196Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":360612605,"revision":32923,"compact-revision":30660} {"level":"info","ts":"2026-10-19T03:04:05.606743Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35215} {"level":"info","ts":"2026-10-19T03:04:05.745429Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35215,"took":"134.639414ms","hash":3265467217,"current-db-size-bytes":60682240,"current-db-size":"61 MB","current-db-size-in-use-bytes":32620544,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-19T03:04:05.745496Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3265467217,"revision":35215,"compact-revision":32923} {"level":"info","ts":"2026-10-19T03:06:47.086736Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"806c7300a47a7256","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-19T03:06:47.092801Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-19T03:06:47.092911Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-19T03:09:05.613591Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37506} {"level":"info","ts":"2026-10-19T03:09:05.748974Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37506,"took":"131.417322ms","hash":1434026728,"current-db-size-bytes":60682240,"current-db-size":"61 MB","current-db-size-in-use-bytes":32788480,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-19T03:09:05.74911Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1434026728,"revision":37506,"compact-revision":35215}