{"level":"warn","ts":"2026-10-15T11:11:46.473621Z","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-15T11:11:46.473739Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.76: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.76:2380","--initial-cluster=instance=https://162.253.55.76:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.76:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.76: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-15T11:11:46.473823Z","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-15T11:11:46.473841Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.76:2380"]} {"level":"info","ts":"2026-10-15T11:11:46.473871Z","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-15T11:11:46.474677Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.76:2379"]} {"level":"info","ts":"2026-10-15T11:11:46.474797Z","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.76:2380"],"listen-peer-urls":["https://162.253.55.76:2380"],"advertise-client-urls":["https://162.253.55.76:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.76:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.76: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-15T11:11:46.478516Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.442959ms"} {"level":"info","ts":"2026-10-15T11:11:46.486102Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"30ad0c2b6ecdd25e","cluster-id":"855d190e6ef0a61f"} {"level":"info","ts":"2026-10-15T11:11:46.486216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e switched to configuration voters=()"} {"level":"info","ts":"2026-10-15T11:11:46.48624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e became follower at term 0"} {"level":"info","ts":"2026-10-15T11:11:46.486252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 30ad0c2b6ecdd25e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-15T11:11:46.486269Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e became follower at term 1"} {"level":"info","ts":"2026-10-15T11:11:46.486327Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e switched to configuration voters=(3507473065473593950)"} {"level":"warn","ts":"2026-10-15T11:11:46.492282Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-15T11:11:46.494842Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-15T11:11:46.496761Z","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-15T11:11:46.499784Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"30ad0c2b6ecdd25e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-15T11:11:46.500016Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"30ad0c2b6ecdd25e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-15T11:11:46.500092Z","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-15T11:11:46.500189Z","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-15T11:11:46.500205Z","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-15T11:11:46.501498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e switched to configuration voters=(3507473065473593950)"} {"level":"info","ts":"2026-10-15T11:11:46.50174Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"855d190e6ef0a61f","local-member-id":"30ad0c2b6ecdd25e","added-peer-id":"30ad0c2b6ecdd25e","added-peer-peer-urls":["https://162.253.55.76:2380"]} {"level":"info","ts":"2026-10-15T11:11:46.502928Z","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-15T11:11:46.502983Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.76:2380"} {"level":"info","ts":"2026-10-15T11:11:46.503036Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.76:2380"} {"level":"info","ts":"2026-10-15T11:11:46.5032Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"30ad0c2b6ecdd25e","initial-advertise-peer-urls":["https://162.253.55.76:2380"],"listen-peer-urls":["https://162.253.55.76:2380"],"advertise-client-urls":["https://162.253.55.76:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.76:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-15T11:11:46.503246Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-15T11:11:46.886769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e is starting a new election at term 1"} {"level":"info","ts":"2026-10-15T11:11:46.886839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e became pre-candidate at term 1"} {"level":"info","ts":"2026-10-15T11:11:46.886877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e received MsgPreVoteResp from 30ad0c2b6ecdd25e at term 1"} {"level":"info","ts":"2026-10-15T11:11:46.886894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e became candidate at term 2"} {"level":"info","ts":"2026-10-15T11:11:46.886902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e received MsgVoteResp from 30ad0c2b6ecdd25e at term 2"} {"level":"info","ts":"2026-10-15T11:11:46.886914Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e became leader at term 2"} {"level":"info","ts":"2026-10-15T11:11:46.886926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 30ad0c2b6ecdd25e elected leader 30ad0c2b6ecdd25e at term 2"} {"level":"info","ts":"2026-10-15T11:11:46.895096Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"30ad0c2b6ecdd25e","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.76:2379]}","request-path":"/0/members/30ad0c2b6ecdd25e/attributes","cluster-id":"855d190e6ef0a61f","publish-timeout":"7s"} {"level":"info","ts":"2026-10-15T11:11:46.895229Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T11:11:46.895146Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T11:11:46.895266Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T11:11:46.895696Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-15T11:11:46.89576Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-15T11:11:46.896551Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"855d190e6ef0a61f","local-member-id":"30ad0c2b6ecdd25e","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T11:11:46.896687Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T11:11:46.896719Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T11:11:46.898401Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.76:2379"} {"level":"info","ts":"2026-10-15T11:11:46.899962Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-10-15T11:12:31.662644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.186056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:12:31.662757Z","caller":"traceutil/trace.go:171","msg":"trace[446879516] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:546; }","duration":"115.310219ms","start":"2026-10-15T11:12:31.547425Z","end":"2026-10-15T11:12:31.662735Z","steps":["trace[446879516] 'range keys from in-memory index tree' (duration: 115.087493ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:32.206824Z","caller":"traceutil/trace.go:171","msg":"trace[1504992999] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"106.682546ms","start":"2026-10-15T11:12:32.100101Z","end":"2026-10-15T11:12:32.206784Z","steps":["trace[1504992999] 'process raft request' (duration: 106.254885ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:32.206897Z","caller":"traceutil/trace.go:171","msg":"trace[1033964793] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"106.88674ms","start":"2026-10-15T11:12:32.09999Z","end":"2026-10-15T11:12:32.206877Z","steps":["trace[1033964793] 'process raft request' (duration: 77.486418ms)","trace[1033964793] 'compare' (duration: 28.750175ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:12:32.207127Z","caller":"traceutil/trace.go:171","msg":"trace[948467296] transaction","detail":"{read_only:false; number_of_response:1; response_revision:557; }","duration":"104.641233ms","start":"2026-10-15T11:12:32.102444Z","end":"2026-10-15T11:12:32.207086Z","steps":["trace[948467296] 'process raft request' (duration: 103.976085ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:38.510223Z","caller":"traceutil/trace.go:171","msg":"trace[1264946950] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"116.465329ms","start":"2026-10-15T11:12:38.393724Z","end":"2026-10-15T11:12:38.510189Z","steps":["trace[1264946950] 'process raft request' (duration: 115.827613ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:39.234407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.857874ms","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-15T11:12:39.234504Z","caller":"traceutil/trace.go:171","msg":"trace[909251268] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:652; }","duration":"177.017428ms","start":"2026-10-15T11:12:39.057464Z","end":"2026-10-15T11:12:39.234482Z","steps":["trace[909251268] 'range keys from in-memory index tree' (duration: 176.587737ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:39.615081Z","caller":"traceutil/trace.go:171","msg":"trace[2117893936] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"500.804282ms","start":"2026-10-15T11:12:39.114263Z","end":"2026-10-15T11:12:39.615067Z","steps":["trace[2117893936] 'process raft request' (duration: 499.248452ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:39.615468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.543567ms","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-15T11:12:39.615564Z","caller":"traceutil/trace.go:171","msg":"trace[1771134487] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:653; }","duration":"404.70233ms","start":"2026-10-15T11:12:39.21084Z","end":"2026-10-15T11:12:39.615542Z","steps":["trace[1771134487] 'agreement among raft nodes before linearized reading' (duration: 404.403373ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:39.615614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:12:39.21082Z","time spent":"404.786083ms","remote":"127.0.0.1:45260","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-15T11:12:39.615019Z","caller":"traceutil/trace.go:171","msg":"trace[1862597960] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:674; }","duration":"404.101935ms","start":"2026-10-15T11:12:39.210896Z","end":"2026-10-15T11:12:39.614998Z","steps":["trace[1862597960] 'read index received' (duration: 401.915479ms)","trace[1862597960] 'applied index is now lower than readState.Index' (duration: 2.185806ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:12:39.618528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:12:39.114229Z","time spent":"500.940156ms","remote":"127.0.0.1:45082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:12:40.11951Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15158730688851819358,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-15T11:12:40.2912Z","caller":"traceutil/trace.go:171","msg":"trace[580996281] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"1.053096369s","start":"2026-10-15T11:12:39.23806Z","end":"2026-10-15T11:12:40.291157Z","steps":["trace[580996281] 'process raft request' (duration: 989.629753ms)","trace[580996281] 'compare' (duration: 62.953762ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:12:40.291401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:12:39.238034Z","time spent":"1.053248002s","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:12:40.780919Z","caller":"traceutil/trace.go:171","msg":"trace[1021115604] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:675; }","duration":"1.164474505s","start":"2026-10-15T11:12:39.61641Z","end":"2026-10-15T11:12:40.780885Z","steps":["trace[1021115604] 'read index received' (duration: 611.193963ms)","trace[1021115604] 'applied index is now lower than readState.Index' (duration: 553.279332ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:12:40.78105Z","caller":"traceutil/trace.go:171","msg":"trace[30385288] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"1.157225498s","start":"2026-10-15T11:12:39.623795Z","end":"2026-10-15T11:12:40.78102Z","steps":["trace[30385288] 'process raft request' (duration: 1.078703002s)","trace[30385288] 'compare' (duration: 78.107115ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:12:40.78107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.435045219s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:12:40.781177Z","caller":"traceutil/trace.go:171","msg":"trace[316218274] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:657; }","duration":"1.435198303s","start":"2026-10-15T11:12:39.345952Z","end":"2026-10-15T11:12:40.78115Z","steps":["trace[316218274] 'agreement among raft nodes before linearized reading' (duration: 1.435012918s)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:40.781195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.568631542s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-10-15T11:12:40.781207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:12:39.623767Z","time spent":"1.15733728s","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:12:40.781226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:12:39.345928Z","time spent":"1.435287726s","remote":"127.0.0.1:45000","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-15T11:12:40.781247Z","caller":"traceutil/trace.go:171","msg":"trace[1210208587] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:657; }","duration":"1.568690243s","start":"2026-10-15T11:12:39.212542Z","end":"2026-10-15T11:12:40.781232Z","steps":["trace[1210208587] 'agreement among raft nodes before linearized reading' (duration: 1.568500408s)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:40.781274Z","caller":"traceutil/trace.go:171","msg":"trace[1724299507] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"880.817823ms","start":"2026-10-15T11:12:39.900438Z","end":"2026-10-15T11:12:40.781256Z","steps":["trace[1724299507] 'process raft request' (duration: 880.381672ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:40.781314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:12:39.212518Z","time spent":"1.568758046s","remote":"127.0.0.1:45260","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-15T11:12:40.781347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.926741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.76\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-10-15T11:12:40.781428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:12:39.900413Z","time spent":"880.953076ms","remote":"127.0.0.1:45260","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-15T11:12:40.781441Z","caller":"traceutil/trace.go:171","msg":"trace[522358247] range","detail":"{range_begin:/registry/masterleases/162.253.55.76; range_end:; response_count:1; response_revision:657; }","duration":"345.106156ms","start":"2026-10-15T11:12:40.436312Z","end":"2026-10-15T11:12:40.781418Z","steps":["trace[522358247] 'agreement among raft nodes before linearized reading' (duration: 344.86238ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:40.781483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:12:40.436281Z","time spent":"345.193149ms","remote":"127.0.0.1:45040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.76\" "} {"level":"warn","ts":"2026-10-15T11:12:40.781169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.297217636s","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-15T11:12:40.780933Z","caller":"traceutil/trace.go:171","msg":"trace[611404470] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"1.10021006s","start":"2026-10-15T11:12:39.680687Z","end":"2026-10-15T11:12:40.780897Z","steps":["trace[611404470] 'process raft request' (duration: 1.100072536s)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:40.781597Z","caller":"traceutil/trace.go:171","msg":"trace[1680453296] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:657; }","duration":"1.297687288s","start":"2026-10-15T11:12:39.483881Z","end":"2026-10-15T11:12:40.781569Z","steps":["trace[1680453296] 'agreement among raft nodes before linearized reading' (duration: 1.297031301s)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:40.781607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:12:39.680663Z","time spent":"1.100901768s","remote":"127.0.0.1:45492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-15T11:12:40.781647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:12:39.483855Z","time spent":"1.297778401s","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-15T11:12:42.986991Z","caller":"traceutil/trace.go:171","msg":"trace[1016771723] linearizableReadLoop","detail":"{readStateIndex:702; appliedIndex:701; }","duration":"199.698537ms","start":"2026-10-15T11:12:42.78726Z","end":"2026-10-15T11:12:42.986958Z","steps":["trace[1016771723] 'read index received' (duration: 144.795504ms)","trace[1016771723] 'applied index is now lower than readState.Index' (duration: 54.901813ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:12:42.987044Z","caller":"traceutil/trace.go:171","msg":"trace[1732631923] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"325.866617ms","start":"2026-10-15T11:12:42.661108Z","end":"2026-10-15T11:12:42.986975Z","steps":["trace[1732631923] 'process raft request' (duration: 271.051017ms)","trace[1732631923] 'compare' (duration: 54.652796ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:12:42.987278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:12:42.661074Z","time spent":"326.081793ms","remote":"127.0.0.1:45072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":763,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-15T11:12:42.987408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.048916ms","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-15T11:12:42.987574Z","caller":"traceutil/trace.go:171","msg":"trace[849570829] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:679; }","duration":"200.327863ms","start":"2026-10-15T11:12:42.787194Z","end":"2026-10-15T11:12:42.987522Z","steps":["trace[849570829] 'agreement among raft nodes before linearized reading' (duration: 199.889091ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:42.987739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.171615ms","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-15T11:12:42.987814Z","caller":"traceutil/trace.go:171","msg":"trace[150512261] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:679; }","duration":"125.284538ms","start":"2026-10-15T11:12:42.862508Z","end":"2026-10-15T11:12:42.987793Z","steps":["trace[150512261] 'agreement among raft nodes before linearized reading' (duration: 124.660691ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:42.987618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.038252ms","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-15T11:12:42.987934Z","caller":"traceutil/trace.go:171","msg":"trace[1941466028] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:679; }","duration":"125.406721ms","start":"2026-10-15T11:12:42.862507Z","end":"2026-10-15T11:12:42.987914Z","steps":["trace[1941466028] 'agreement among raft nodes before linearized reading' (duration: 124.732363ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:12:57.367455Z","caller":"traceutil/trace.go:171","msg":"trace[141128922] linearizableReadLoop","detail":"{readStateIndex:850; appliedIndex:849; }","duration":"252.786542ms","start":"2026-10-15T11:12:57.114641Z","end":"2026-10-15T11:12:57.367427Z","steps":["trace[141128922] 'read index received' (duration: 252.460864ms)","trace[141128922] 'applied index is now lower than readState.Index' (duration: 324.548µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:12:57.36752Z","caller":"traceutil/trace.go:171","msg":"trace[1890986841] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"286.781224ms","start":"2026-10-15T11:12:57.080712Z","end":"2026-10-15T11:12:57.367493Z","steps":["trace[1890986841] 'process raft request' (duration: 286.487247ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:57.367655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.985378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T11:12:57.36773Z","caller":"traceutil/trace.go:171","msg":"trace[473299344] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:822; }","duration":"253.136342ms","start":"2026-10-15T11:12:57.114575Z","end":"2026-10-15T11:12:57.367712Z","steps":["trace[473299344] 'agreement among raft nodes before linearized reading' (duration: 252.971828ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:57.368562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.050235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-15T11:12:57.368659Z","caller":"traceutil/trace.go:171","msg":"trace[849490104] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:822; }","duration":"183.180509ms","start":"2026-10-15T11:12:57.185457Z","end":"2026-10-15T11:12:57.368637Z","steps":["trace[849490104] 'agreement among raft nodes before linearized reading' (duration: 182.922002ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:57.369003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.395067ms","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-15T11:12:57.369077Z","caller":"traceutil/trace.go:171","msg":"trace[1172774563] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:822; }","duration":"197.51752ms","start":"2026-10-15T11:12:57.171542Z","end":"2026-10-15T11:12:57.36906Z","steps":["trace[1172774563] 'agreement among raft nodes before linearized reading' (duration: 196.36987ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:12:57.368796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.082791ms","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-15T11:12:57.369219Z","caller":"traceutil/trace.go:171","msg":"trace[654289639] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:822; }","duration":"194.542073ms","start":"2026-10-15T11:12:57.174651Z","end":"2026-10-15T11:12:57.369193Z","steps":["trace[654289639] 'agreement among raft nodes before linearized reading' (duration: 193.984119ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:13:27.694127Z","caller":"traceutil/trace.go:171","msg":"trace[1572840771] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"148.752043ms","start":"2026-10-15T11:13:27.545331Z","end":"2026-10-15T11:13:27.694083Z","steps":["trace[1572840771] 'process raft request' (duration: 148.425694ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:13:27.833041Z","caller":"traceutil/trace.go:171","msg":"trace[1339877114] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"133.372143ms","start":"2026-10-15T11:13:27.699641Z","end":"2026-10-15T11:13:27.833013Z","steps":["trace[1339877114] 'process raft request' (duration: 133.214609ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:13:27.842656Z","caller":"traceutil/trace.go:171","msg":"trace[1111991743] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"142.295925ms","start":"2026-10-15T11:13:27.700316Z","end":"2026-10-15T11:13:27.842612Z","steps":["trace[1111991743] 'process raft request' (duration: 142.231033ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:13:27.842683Z","caller":"traceutil/trace.go:171","msg":"trace[485489156] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"142.765407ms","start":"2026-10-15T11:13:27.69989Z","end":"2026-10-15T11:13:27.842656Z","steps":["trace[485489156] 'process raft request' (duration: 142.568582ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:13:48.916879Z","caller":"traceutil/trace.go:171","msg":"trace[901628423] transaction","detail":"{read_only:false; response_revision:1475; number_of_response:1; }","duration":"181.505872ms","start":"2026-10-15T11:13:48.735336Z","end":"2026-10-15T11:13:48.916842Z","steps":["trace[901628423] 'process raft request' (duration: 181.113582ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:14:14.864646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.459859ms","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":"warn","ts":"2026-10-15T11:14:14.86469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.678165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-10-15T11:14:14.865019Z","caller":"traceutil/trace.go:171","msg":"trace[1458583139] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1882; }","duration":"629.047205ms","start":"2026-10-15T11:14:14.235934Z","end":"2026-10-15T11:14:14.864981Z","steps":["trace[1458583139] 'range keys from in-memory index tree' (duration: 628.49064ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:14:14.865029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.845838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f78f65f9-61eb-43c3-8953-5bb3c4055038\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-10-15T11:14:14.864963Z","caller":"traceutil/trace.go:171","msg":"trace[1694166178] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1882; }","duration":"581.831419ms","start":"2026-10-15T11:14:14.283095Z","end":"2026-10-15T11:14:14.864927Z","steps":["trace[1694166178] 'range keys from in-memory index tree' (duration: 581.192032ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:14:14.8651Z","caller":"traceutil/trace.go:171","msg":"trace[641678854] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f78f65f9-61eb-43c3-8953-5bb3c4055038; range_end:; response_count:1; response_revision:1882; }","duration":"440.945271ms","start":"2026-10-15T11:14:14.424131Z","end":"2026-10-15T11:14:14.865076Z","steps":["trace[641678854] 'range keys from in-memory index tree' (duration: 440.643183ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:14:14.865172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:14:14.424109Z","time spent":"441.048503ms","remote":"127.0.0.1:45168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f78f65f9-61eb-43c3-8953-5bb3c4055038\" "} {"level":"warn","ts":"2026-10-15T11:14:14.865238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:14:14.283066Z","time spent":"582.116436ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-10-15T11:14:14.864801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.055147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:14:14.865446Z","caller":"traceutil/trace.go:171","msg":"trace[1891650681] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1882; }","duration":"455.773285ms","start":"2026-10-15T11:14:14.409628Z","end":"2026-10-15T11:14:14.865402Z","steps":["trace[1891650681] 'count revisions from in-memory index tree' (duration: 454.918443ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:14:14.865545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:14:14.409604Z","time spent":"455.907159ms","remote":"127.0.0.1:47794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-10-15T11:14:14.864742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.652468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:14:14.865735Z","caller":"traceutil/trace.go:171","msg":"trace[1937098960] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1882; }","duration":"519.659094ms","start":"2026-10-15T11:14:14.34604Z","end":"2026-10-15T11:14:14.865699Z","steps":["trace[1937098960] 'range keys from in-memory index tree' (duration: 518.556936ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:14:14.8658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:14:14.346019Z","time spent":"519.761847ms","remote":"127.0.0.1:45000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-15T11:14:14.865657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:14:14.235902Z","time spent":"629.161227ms","remote":"127.0.0.1:34262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-10-15T11:14:14.959767Z","caller":"traceutil/trace.go:171","msg":"trace[191171920] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"325.40322ms","start":"2026-10-15T11:14:14.634345Z","end":"2026-10-15T11:14:14.959748Z","steps":["trace[191171920] 'process raft request' (duration: 325.280857ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:14:14.959891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:14:14.634314Z","time spent":"325.509962ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:14:14.960003Z","caller":"traceutil/trace.go:171","msg":"trace[689286094] linearizableReadLoop","detail":"{readStateIndex:1955; appliedIndex:1955; }","duration":"294.682503ms","start":"2026-10-15T11:14:14.665286Z","end":"2026-10-15T11:14:14.959968Z","steps":["trace[689286094] 'read index received' (duration: 294.673672ms)","trace[689286094] 'applied index is now lower than readState.Index' (duration: 6.941µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:14:14.9602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.883637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T11:14:14.960281Z","caller":"traceutil/trace.go:171","msg":"trace[1228245558] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1883; }","duration":"295.028031ms","start":"2026-10-15T11:14:14.665234Z","end":"2026-10-15T11:14:14.960262Z","steps":["trace[1228245558] 'agreement among raft nodes before linearized reading' (duration: 294.848927ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:14:15.270864Z","caller":"traceutil/trace.go:171","msg":"trace[2136678771] linearizableReadLoop","detail":"{readStateIndex:1956; appliedIndex:1955; }","duration":"310.746089ms","start":"2026-10-15T11:14:14.960089Z","end":"2026-10-15T11:14:15.270835Z","steps":["trace[2136678771] 'read index received' (duration: 310.636106ms)","trace[2136678771] 'applied index is now lower than readState.Index' (duration: 108.943µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:14:15.270944Z","caller":"traceutil/trace.go:171","msg":"trace[1544813728] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"400.705575ms","start":"2026-10-15T11:14:14.870214Z","end":"2026-10-15T11:14:15.270919Z","steps":["trace[1544813728] 'process raft request' (duration: 400.414628ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:14:15.271078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.228086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T11:14:15.271117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.771815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f78f65f9-61eb-43c3-8953-5bb3c4055038\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-10-15T11:14:15.271169Z","caller":"traceutil/trace.go:171","msg":"trace[832919878] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1884; }","duration":"404.37971ms","start":"2026-10-15T11:14:14.866767Z","end":"2026-10-15T11:14:15.271147Z","steps":["trace[832919878] 'agreement among raft nodes before linearized reading' (duration: 404.200255ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:14:15.271172Z","caller":"traceutil/trace.go:171","msg":"trace[983330364] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f78f65f9-61eb-43c3-8953-5bb3c4055038; range_end:; response_count:1; response_revision:1884; }","duration":"450.869017ms","start":"2026-10-15T11:14:14.820287Z","end":"2026-10-15T11:14:15.271156Z","steps":["trace[983330364] 'agreement among raft nodes before linearized reading' (duration: 450.676072ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:14:15.27121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:14:14.866747Z","time spent":"404.454882ms","remote":"127.0.0.1:45002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-15T11:14:15.271217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:14:14.820265Z","time spent":"450.939939ms","remote":"127.0.0.1:45168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f78f65f9-61eb-43c3-8953-5bb3c4055038\" "} {"level":"warn","ts":"2026-10-15T11:14:15.271233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:14:14.870197Z","time spent":"400.796897ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:14:15.49315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.823443ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T11:14:15.493315Z","caller":"traceutil/trace.go:171","msg":"trace[2082236581] linearizableReadLoop","detail":"{readStateIndex:1958; appliedIndex:1956; }","duration":"222.357884ms","start":"2026-10-15T11:14:15.270939Z","end":"2026-10-15T11:14:15.493297Z","steps":["trace[2082236581] 'read index received' (duration: 90.204102ms)","trace[2082236581] 'applied index is now lower than readState.Index' (duration: 132.152602ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:14:15.493432Z","caller":"traceutil/trace.go:171","msg":"trace[1551384873] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"323.83792ms","start":"2026-10-15T11:14:15.169579Z","end":"2026-10-15T11:14:15.493417Z","steps":["trace[1551384873] 'process raft request' (duration: 323.645785ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:14:15.493518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:14:15.169552Z","time spent":"323.919481ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:14:15.49356Z","caller":"traceutil/trace.go:171","msg":"trace[1302496021] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"357.345319ms","start":"2026-10-15T11:14:15.136183Z","end":"2026-10-15T11:14:15.493529Z","steps":["trace[1302496021] 'process raft request' (duration: 224.9391ms)","trace[1302496021] 'compare' (duration: 131.69834ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:14:15.493605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.670401ms","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-15T11:14:15.49366Z","caller":"traceutil/trace.go:171","msg":"trace[1445933091] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1886; }","duration":"448.789564ms","start":"2026-10-15T11:14:15.044855Z","end":"2026-10-15T11:14:15.493645Z","steps":["trace[1445933091] 'agreement among raft nodes before linearized reading' (duration: 448.571168ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:14:15.493713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:14:15.044826Z","time spent":"448.875536ms","remote":"127.0.0.1:45260","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-15T11:14:15.493729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:14:15.136157Z","time spent":"357.487383ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:14:15.993922Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15158730688851821812,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-15T11:14:16.067271Z","caller":"traceutil/trace.go:171","msg":"trace[196400315] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"787.230762ms","start":"2026-10-15T11:14:15.280017Z","end":"2026-10-15T11:14:16.067248Z","steps":["trace[196400315] 'process raft request' (duration: 787.068808ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:14:16.067457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:14:15.279994Z","time spent":"787.345685ms","remote":"127.0.0.1:45168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3731,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:14:16.07134Z","caller":"traceutil/trace.go:171","msg":"trace[1862803550] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"573.526583ms","start":"2026-10-15T11:14:15.497778Z","end":"2026-10-15T11:14:16.071305Z","steps":["trace[1862803550] 'process raft request' (duration: 572.756153ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:14:16.071533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:14:15.497757Z","time spent":"573.694527ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:14:16.110606Z","caller":"traceutil/trace.go:171","msg":"trace[2047429659] linearizableReadLoop","detail":"{readStateIndex:1962; appliedIndex:1958; }","duration":"617.200757ms","start":"2026-10-15T11:14:15.493382Z","end":"2026-10-15T11:14:16.110583Z","steps":["trace[2047429659] 'read index received' (duration: 573.704877ms)","trace[2047429659] 'applied index is now lower than readState.Index' (duration: 43.49496ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:14:16.110744Z","caller":"traceutil/trace.go:171","msg":"trace[1272066362] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"307.462654ms","start":"2026-10-15T11:14:15.803203Z","end":"2026-10-15T11:14:16.110666Z","steps":["trace[1272066362] 'process raft request' (duration: 307.250448ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:14:16.110836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.78767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:14:16.110877Z","caller":"traceutil/trace.go:171","msg":"trace[352647791] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1889; }","duration":"439.890973ms","start":"2026-10-15T11:14:15.670974Z","end":"2026-10-15T11:14:16.110865Z","steps":["trace[352647791] 'agreement among raft nodes before linearized reading' (duration: 439.799611ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:14:16.110914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:14:15.670953Z","time spent":"439.950714ms","remote":"127.0.0.1:47824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-10-15T11:14:16.110927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:14:15.803175Z","time spent":"307.643879ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:14:16.11097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.992814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"warn","ts":"2026-10-15T11:14:16.110968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"763.104685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"} {"level":"info","ts":"2026-10-15T11:14:16.111036Z","caller":"traceutil/trace.go:171","msg":"trace[444655203] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1889; }","duration":"237.093787ms","start":"2026-10-15T11:14:15.873927Z","end":"2026-10-15T11:14:16.11102Z","steps":["trace[444655203] 'agreement among raft nodes before linearized reading' (duration: 236.914192ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:14:16.111082Z","caller":"traceutil/trace.go:171","msg":"trace[1819217876] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1889; }","duration":"763.28071ms","start":"2026-10-15T11:14:15.347768Z","end":"2026-10-15T11:14:16.111048Z","steps":["trace[1819217876] 'agreement among raft nodes before linearized reading' (duration: 762.957231ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:14:16.111103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.85259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-10-15T11:14:16.111142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.948013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f78f65f9-61eb-43c3-8953-5bb3c4055038\" ","response":"range_response_count:1 size:3746"} {"level":"info","ts":"2026-10-15T11:14:16.111218Z","caller":"traceutil/trace.go:171","msg":"trace[1076518473] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1889; }","duration":"137.996694ms","start":"2026-10-15T11:14:15.973196Z","end":"2026-10-15T11:14:16.111193Z","steps":["trace[1076518473] 'agreement among raft nodes before linearized reading' (duration: 137.622634ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:14:16.111245Z","caller":"traceutil/trace.go:171","msg":"trace[1656289922] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f78f65f9-61eb-43c3-8953-5bb3c4055038; range_end:; response_count:1; response_revision:1889; }","duration":"242.121647ms","start":"2026-10-15T11:14:15.869098Z","end":"2026-10-15T11:14:16.11122Z","steps":["trace[1656289922] 'agreement among raft nodes before linearized reading' (duration: 241.802819ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:14:16.11114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:14:15.347756Z","time spent":"763.370083ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":593,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"info","ts":"2026-10-15T11:14:36.493263Z","caller":"traceutil/trace.go:171","msg":"trace[1983886092] transaction","detail":"{read_only:false; response_revision:2058; number_of_response:1; }","duration":"105.239888ms","start":"2026-10-15T11:14:36.387987Z","end":"2026-10-15T11:14:36.493227Z","steps":["trace[1983886092] 'process raft request' (duration: 103.78464ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:14:36.493788Z","caller":"traceutil/trace.go:171","msg":"trace[39732565] transaction","detail":"{read_only:false; response_revision:2059; number_of_response:1; }","duration":"105.023422ms","start":"2026-10-15T11:14:36.388473Z","end":"2026-10-15T11:14:36.493496Z","steps":["trace[39732565] 'process raft request' (duration: 104.684563ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:00.999521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.358326ms","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-15T11:15:00.999598Z","caller":"traceutil/trace.go:171","msg":"trace[145823661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2186; }","duration":"402.4956ms","start":"2026-10-15T11:15:00.597084Z","end":"2026-10-15T11:15:00.99958Z","steps":["trace[145823661] 'range keys from in-memory index tree' (duration: 402.105189ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:00.99964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:00.59706Z","time spent":"402.567991ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-15T11:15:00.99972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.096879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"} {"level":"info","ts":"2026-10-15T11:15:00.999795Z","caller":"traceutil/trace.go:171","msg":"trace[1234798480] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2186; }","duration":"402.186912ms","start":"2026-10-15T11:15:00.597572Z","end":"2026-10-15T11:15:00.999759Z","steps":["trace[1234798480] 'range keys from in-memory index tree' (duration: 401.926275ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:00.999845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:00.597551Z","time spent":"402.281873ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":593,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-10-15T11:15:00.999631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.482049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-15T11:15:01.00026Z","caller":"traceutil/trace.go:171","msg":"trace[1789271389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2186; }","duration":"403.161877ms","start":"2026-10-15T11:15:00.597084Z","end":"2026-10-15T11:15:01.000246Z","steps":["trace[1789271389] 'range keys from in-memory index tree' (duration: 402.306724ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:01.0003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:00.597057Z","time spent":"403.231438ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-15T11:15:01.235108Z","caller":"traceutil/trace.go:171","msg":"trace[1980831532] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"229.713018ms","start":"2026-10-15T11:15:01.005365Z","end":"2026-10-15T11:15:01.235078Z","steps":["trace[1980831532] 'process raft request' (duration: 229.560784ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:01.477771Z","caller":"traceutil/trace.go:171","msg":"trace[1447204285] linearizableReadLoop","detail":"{readStateIndex:2271; appliedIndex:2269; }","duration":"340.745187ms","start":"2026-10-15T11:15:01.136996Z","end":"2026-10-15T11:15:01.477741Z","steps":["trace[1447204285] 'read index received' (duration: 98.078511ms)","trace[1447204285] 'applied index is now lower than readState.Index' (duration: 242.665496ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:15:01.477785Z","caller":"traceutil/trace.go:171","msg":"trace[1444829651] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"471.916272ms","start":"2026-10-15T11:15:01.005817Z","end":"2026-10-15T11:15:01.477733Z","steps":["trace[1444829651] 'process raft request' (duration: 402.546311ms)","trace[1444829651] 'compare' (duration: 68.997871ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:15:01.477869Z","caller":"traceutil/trace.go:171","msg":"trace[1469974330] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"471.356587ms","start":"2026-10-15T11:15:01.00647Z","end":"2026-10-15T11:15:01.477826Z","steps":["trace[1469974330] 'process raft request' (duration: 471.157512ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:01.477963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:01.005794Z","time spent":"472.083077ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:15:01.477989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.122398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-15T11:15:01.477986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.951012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T11:15:01.478072Z","caller":"traceutil/trace.go:171","msg":"trace[1303126427] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2189; }","duration":"323.270601ms","start":"2026-10-15T11:15:01.154781Z","end":"2026-10-15T11:15:01.478052Z","steps":["trace[1303126427] 'agreement among raft nodes before linearized reading' (duration: 323.132678ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:01.478087Z","caller":"traceutil/trace.go:171","msg":"trace[877166155] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:2189; }","duration":"341.117628ms","start":"2026-10-15T11:15:01.136947Z","end":"2026-10-15T11:15:01.478065Z","steps":["trace[877166155] 'agreement among raft nodes before linearized reading' (duration: 340.893782ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:01.478096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:01.00646Z","time spent":"471.503162ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:15:01.478132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:01.136925Z","time spent":"341.196089ms","remote":"127.0.0.1:34616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":13,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-10-15T11:15:01.478127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:01.15476Z","time spent":"323.348113ms","remote":"127.0.0.1:47882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-10-15T11:15:01.676113Z","caller":"traceutil/trace.go:171","msg":"trace[1626431402] transaction","detail":"{read_only:false; response_revision:2190; number_of_response:1; }","duration":"124.600754ms","start":"2026-10-15T11:15:01.551478Z","end":"2026-10-15T11:15:01.676079Z","steps":["trace[1626431402] 'process raft request' (duration: 54.220296ms)","trace[1626431402] 'compare' (duration: 70.254815ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:15:02.162767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.919386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T11:15:02.162884Z","caller":"traceutil/trace.go:171","msg":"trace[289954957] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:2191; }","duration":"291.114191ms","start":"2026-10-15T11:15:01.871743Z","end":"2026-10-15T11:15:02.162857Z","steps":["trace[289954957] 'count revisions from in-memory index tree' (duration: 290.785433ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:02.163047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.155183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:15:02.163494Z","caller":"traceutil/trace.go:171","msg":"trace[481567812] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2191; }","duration":"237.663416ms","start":"2026-10-15T11:15:01.925803Z","end":"2026-10-15T11:15:02.163467Z","steps":["trace[481567812] 'range keys from in-memory index tree' (duration: 237.05464ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:02.485654Z","caller":"traceutil/trace.go:171","msg":"trace[858668171] linearizableReadLoop","detail":"{readStateIndex:2274; appliedIndex:2273; }","duration":"169.765503ms","start":"2026-10-15T11:15:02.315863Z","end":"2026-10-15T11:15:02.485629Z","steps":["trace[858668171] 'read index received' (duration: 169.536757ms)","trace[858668171] 'applied index is now lower than readState.Index' (duration: 227.596µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:15:02.485726Z","caller":"traceutil/trace.go:171","msg":"trace[566044442] transaction","detail":"{read_only:false; response_revision:2192; number_of_response:1; }","duration":"183.759748ms","start":"2026-10-15T11:15:02.301944Z","end":"2026-10-15T11:15:02.485704Z","steps":["trace[566044442] 'process raft request' (duration: 183.514072ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:02.485892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.654243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:15:02.485982Z","caller":"traceutil/trace.go:171","msg":"trace[2007311955] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2192; }","duration":"140.791767ms","start":"2026-10-15T11:15:02.34517Z","end":"2026-10-15T11:15:02.485962Z","steps":["trace[2007311955] 'agreement among raft nodes before linearized reading' (duration: 140.651373ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:02.485995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.108302ms","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-15T11:15:02.486051Z","caller":"traceutil/trace.go:171","msg":"trace[1853039206] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2192; }","duration":"170.214555ms","start":"2026-10-15T11:15:02.315819Z","end":"2026-10-15T11:15:02.486033Z","steps":["trace[1853039206] 'agreement among raft nodes before linearized reading' (duration: 169.960448ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:02.486122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.841117ms","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-15T11:15:02.486209Z","caller":"traceutil/trace.go:171","msg":"trace[1220005938] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2192; }","duration":"122.968601ms","start":"2026-10-15T11:15:02.363222Z","end":"2026-10-15T11:15:02.486191Z","steps":["trace[1220005938] 'agreement among raft nodes before linearized reading' (duration: 122.704844ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:07.875015Z","caller":"traceutil/trace.go:171","msg":"trace[696405598] transaction","detail":"{read_only:false; response_revision:2220; number_of_response:1; }","duration":"358.527571ms","start":"2026-10-15T11:15:07.516453Z","end":"2026-10-15T11:15:07.874981Z","steps":["trace[696405598] 'process raft request' (duration: 358.305425ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:07.875368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:07.516401Z","time spent":"358.831989ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:15:08.214224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.691207ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T11:15:08.214526Z","caller":"traceutil/trace.go:171","msg":"trace[1093853245] transaction","detail":"{read_only:false; response_revision:2222; number_of_response:1; }","duration":"695.574681ms","start":"2026-10-15T11:15:07.518929Z","end":"2026-10-15T11:15:08.214504Z","steps":["trace[1093853245] 'process raft request' (duration: 695.402557ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:08.214513Z","caller":"traceutil/trace.go:171","msg":"trace[473172626] transaction","detail":"{read_only:false; response_revision:2221; number_of_response:1; }","duration":"697.083501ms","start":"2026-10-15T11:15:07.517398Z","end":"2026-10-15T11:15:08.214481Z","steps":["trace[473172626] 'process raft request' (duration: 467.048174ms)","trace[473172626] 'compare' (duration: 229.369029ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:15:08.214603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:07.518918Z","time spent":"695.651753ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:15:08.21467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:07.517359Z","time spent":"697.234184ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:15:08.214827Z","caller":"traceutil/trace.go:171","msg":"trace[136945369] transaction","detail":"{read_only:false; response_revision:2223; number_of_response:1; }","duration":"447.479764ms","start":"2026-10-15T11:15:07.767335Z","end":"2026-10-15T11:15:08.214815Z","steps":["trace[136945369] 'process raft request' (duration: 447.129575ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:08.214802Z","caller":"traceutil/trace.go:171","msg":"trace[488895432] linearizableReadLoop","detail":"{readStateIndex:2306; appliedIndex:2303; }","duration":"664.438518ms","start":"2026-10-15T11:15:07.550336Z","end":"2026-10-15T11:15:08.214774Z","steps":["trace[488895432] 'read index received' (duration: 324.498532ms)","trace[488895432] 'applied index is now lower than readState.Index' (duration: 339.938266ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:15:08.214888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:07.767301Z","time spent":"447.552816ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:15:08.215011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.312702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:15:08.215068Z","caller":"traceutil/trace.go:171","msg":"trace[2070390933] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:2223; }","duration":"436.388854ms","start":"2026-10-15T11:15:07.778663Z","end":"2026-10-15T11:15:08.215052Z","steps":["trace[2070390933] 'agreement among raft nodes before linearized reading' (duration: 436.278352ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:08.215118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:07.778604Z","time spent":"436.499757ms","remote":"127.0.0.1:47678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-10-15T11:15:08.215171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.440858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18deafb39c6a64ef\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-10-15T11:15:08.215218Z","caller":"traceutil/trace.go:171","msg":"trace[388110438] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18deafb39c6a64ef; range_end:; response_count:1; response_revision:2223; }","duration":"510.54244ms","start":"2026-10-15T11:15:07.704664Z","end":"2026-10-15T11:15:08.215206Z","steps":["trace[388110438] 'agreement among raft nodes before linearized reading' (duration: 510.394707ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:08.215263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:07.70463Z","time spent":"510.625643ms","remote":"127.0.0.1:45072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":869,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18deafb39c6a64ef\" "} {"level":"warn","ts":"2026-10-15T11:15:08.215465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.446729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-10-15T11:15:08.21565Z","caller":"traceutil/trace.go:171","msg":"trace[376841368] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2223; }","duration":"623.768367ms","start":"2026-10-15T11:15:07.591775Z","end":"2026-10-15T11:15:08.215544Z","steps":["trace[376841368] 'agreement among raft nodes before linearized reading' (duration: 623.164942ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:08.215746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.401623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-15T11:15:08.215791Z","caller":"traceutil/trace.go:171","msg":"trace[1535202894] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:2223; }","duration":"665.476504ms","start":"2026-10-15T11:15:07.550304Z","end":"2026-10-15T11:15:08.21578Z","steps":["trace[1535202894] 'agreement among raft nodes before linearized reading' (duration: 664.641663ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:08.215801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:07.591752Z","time spent":"624.030033ms","remote":"127.0.0.1:34262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-10-15T11:15:08.21582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:07.550288Z","time spent":"665.523416ms","remote":"127.0.0.1:45072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":273,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-10-15T11:15:08.21525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.330607ms","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-15T11:15:08.216212Z","caller":"traceutil/trace.go:171","msg":"trace[1583507827] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2223; }","duration":"508.322463ms","start":"2026-10-15T11:15:07.707868Z","end":"2026-10-15T11:15:08.21619Z","steps":["trace[1583507827] 'agreement among raft nodes before linearized reading' (duration: 507.114292ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:08.216254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:07.707788Z","time spent":"508.451006ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-10-15T11:15:08.791946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.188162ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T11:15:08.792236Z","caller":"traceutil/trace.go:171","msg":"trace[1770951835] linearizableReadLoop","detail":"{readStateIndex:2309; appliedIndex:2307; }","duration":"447.093554ms","start":"2026-10-15T11:15:08.345123Z","end":"2026-10-15T11:15:08.792217Z","steps":["trace[1770951835] 'read index received' (duration: 260.549363ms)","trace[1770951835] 'applied index is now lower than readState.Index' (duration: 186.543111ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:15:08.792357Z","caller":"traceutil/trace.go:171","msg":"trace[29114853] transaction","detail":"{read_only:false; response_revision:2225; number_of_response:1; }","duration":"570.647841ms","start":"2026-10-15T11:15:08.221634Z","end":"2026-10-15T11:15:08.792282Z","steps":["trace[29114853] 'process raft request' (duration: 570.449105ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:08.792599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:08.221621Z","time spent":"570.858906ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:15:08.79259Z","caller":"traceutil/trace.go:171","msg":"trace[270532592] transaction","detail":"{read_only:false; response_revision:2226; number_of_response:1; }","duration":"282.666431ms","start":"2026-10-15T11:15:08.509791Z","end":"2026-10-15T11:15:08.792458Z","steps":["trace[270532592] 'process raft request' (duration: 282.376544ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:08.792706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.939709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T11:15:08.792739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.218112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-10-15T11:15:08.792747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.574446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:15:08.792791Z","caller":"traceutil/trace.go:171","msg":"trace[37877430] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2226; }","duration":"235.308883ms","start":"2026-10-15T11:15:08.557468Z","end":"2026-10-15T11:15:08.792777Z","steps":["trace[37877430] 'agreement among raft nodes before linearized reading' (duration: 235.133309ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:08.792803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.196955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-15T11:15:08.792796Z","caller":"traceutil/trace.go:171","msg":"trace[1652321026] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2226; }","duration":"221.063832ms","start":"2026-10-15T11:15:08.571709Z","end":"2026-10-15T11:15:08.792773Z","steps":["trace[1652321026] 'agreement among raft nodes before linearized reading' (duration: 220.918619ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:08.792865Z","caller":"traceutil/trace.go:171","msg":"trace[1362258616] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2226; }","duration":"229.286326ms","start":"2026-10-15T11:15:08.563562Z","end":"2026-10-15T11:15:08.792849Z","steps":["trace[1362258616] 'agreement among raft nodes before linearized reading' (duration: 229.098621ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:08.792961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.76572ms","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-15T11:15:08.793095Z","caller":"traceutil/trace.go:171","msg":"trace[1876146797] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2226; }","duration":"234.919483ms","start":"2026-10-15T11:15:08.558124Z","end":"2026-10-15T11:15:08.793044Z","steps":["trace[1876146797] 'agreement among raft nodes before linearized reading' (duration: 234.601355ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:08.793078Z","caller":"traceutil/trace.go:171","msg":"trace[1698971189] transaction","detail":"{read_only:false; response_revision:2224; number_of_response:1; }","duration":"573.961287ms","start":"2026-10-15T11:15:08.218228Z","end":"2026-10-15T11:15:08.79219Z","steps":["trace[1698971189] 'process raft request' (duration: 387.432777ms)","trace[1698971189] 'compare' (duration: 186.064858ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:15:08.793316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.745574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12384"} {"level":"info","ts":"2026-10-15T11:15:08.79341Z","caller":"traceutil/trace.go:171","msg":"trace[1539654478] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2226; }","duration":"203.150465ms","start":"2026-10-15T11:15:08.590216Z","end":"2026-10-15T11:15:08.793366Z","steps":["trace[1539654478] 'agreement among raft nodes before linearized reading' (duration: 202.493058ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:15:08.79287Z","caller":"traceutil/trace.go:171","msg":"trace[279479620] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2226; }","duration":"447.72327ms","start":"2026-10-15T11:15:08.345067Z","end":"2026-10-15T11:15:08.79279Z","steps":["trace[279479620] 'agreement among raft nodes before linearized reading' (duration: 447.582996ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:15:08.793436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:08.218203Z","time spent":"575.020484ms","remote":"127.0.0.1:45072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:15:08.793664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:15:08.345038Z","time spent":"448.565542ms","remote":"127.0.0.1:45000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-15T11:16:27.05183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.355696ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T11:16:27.051935Z","caller":"traceutil/trace.go:171","msg":"trace[305268672] linearizableReadLoop","detail":"{readStateIndex:2797; appliedIndex:2796; }","duration":"359.831857ms","start":"2026-10-15T11:16:26.692087Z","end":"2026-10-15T11:16:27.051919Z","steps":["trace[305268672] 'read index received' (duration: 116.172883ms)","trace[305268672] 'applied index is now lower than readState.Index' (duration: 243.657904ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:16:27.052093Z","caller":"traceutil/trace.go:171","msg":"trace[682316459] transaction","detail":"{read_only:false; response_revision:2696; number_of_response:1; }","duration":"361.599353ms","start":"2026-10-15T11:16:26.690442Z","end":"2026-10-15T11:16:27.052042Z","steps":["trace[682316459] 'process raft request' (duration: 117.96524ms)","trace[682316459] 'compare' (duration: 243.239743ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:16:27.052165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.069054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"} {"level":"info","ts":"2026-10-15T11:16:27.05223Z","caller":"traceutil/trace.go:171","msg":"trace[1487885502] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2696; }","duration":"360.209297ms","start":"2026-10-15T11:16:26.692004Z","end":"2026-10-15T11:16:27.052213Z","steps":["trace[1487885502] 'agreement among raft nodes before linearized reading' (duration: 359.988631ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:16:27.052269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:16:26.691962Z","time spent":"360.29859ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":593,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-10-15T11:16:27.052475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:16:26.69039Z","time spent":"361.85036ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:20:06.624052Z","caller":"traceutil/trace.go:171","msg":"trace[880469064] transaction","detail":"{read_only:false; response_revision:4029; number_of_response:1; }","duration":"165.991333ms","start":"2026-10-15T11:20:06.458001Z","end":"2026-10-15T11:20:06.623992Z","steps":["trace[880469064] 'process raft request' (duration: 165.48479ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:29.286795Z","caller":"traceutil/trace.go:171","msg":"trace[70299924] transaction","detail":"{read_only:false; response_revision:4880; number_of_response:1; }","duration":"195.735521ms","start":"2026-10-15T11:21:29.091011Z","end":"2026-10-15T11:21:29.286746Z","steps":["trace[70299924] 'process raft request' (duration: 176.410856ms)","trace[70299924] 'compare' (duration: 18.954255ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:21:29.28675Z","caller":"traceutil/trace.go:171","msg":"trace[1468793934] linearizableReadLoop","detail":"{readStateIndex:5070; appliedIndex:5069; }","duration":"194.238172ms","start":"2026-10-15T11:21:29.09243Z","end":"2026-10-15T11:21:29.286668Z","steps":["trace[1468793934] 'read index received' (duration: 175.140042ms)","trace[1468793934] 'applied index is now lower than readState.Index' (duration: 19.09628ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:21:29.287146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.669193ms","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-15T11:21:29.287288Z","caller":"traceutil/trace.go:171","msg":"trace[775216738] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4880; }","duration":"194.862908ms","start":"2026-10-15T11:21:29.09239Z","end":"2026-10-15T11:21:29.287253Z","steps":["trace[775216738] 'agreement among raft nodes before linearized reading' (duration: 194.467328ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:29.343046Z","caller":"traceutil/trace.go:171","msg":"trace[1610004082] transaction","detail":"{read_only:false; response_revision:4881; number_of_response:1; }","duration":"249.725624ms","start":"2026-10-15T11:21:29.093279Z","end":"2026-10-15T11:21:29.343005Z","steps":["trace[1610004082] 'process raft request' (duration: 249.209001ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:29.343818Z","caller":"traceutil/trace.go:171","msg":"trace[1112031887] transaction","detail":"{read_only:false; response_revision:4882; number_of_response:1; }","duration":"240.630846ms","start":"2026-10-15T11:21:29.103166Z","end":"2026-10-15T11:21:29.343797Z","steps":["trace[1112031887] 'process raft request' (duration: 239.618819ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:29.344596Z","caller":"traceutil/trace.go:171","msg":"trace[1935254784] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4882; }","duration":"198.741961ms","start":"2026-10-15T11:21:29.145767Z","end":"2026-10-15T11:21:29.344509Z","steps":["trace[1935254784] 'process raft request' (duration: 197.629211ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:29.346159Z","caller":"traceutil/trace.go:171","msg":"trace[1481236336] transaction","detail":"{read_only:false; response_revision:4883; number_of_response:1; }","duration":"107.075322ms","start":"2026-10-15T11:21:29.239053Z","end":"2026-10-15T11:21:29.346128Z","steps":["trace[1481236336] 'process raft request' (duration: 105.612014ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:21:29.346728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.973225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T11:21:29.346856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.661885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T11:21:29.346891Z","caller":"traceutil/trace.go:171","msg":"trace[2082463842] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:4884; }","duration":"241.132989ms","start":"2026-10-15T11:21:29.10568Z","end":"2026-10-15T11:21:29.346813Z","steps":["trace[2082463842] 'agreement among raft nodes before linearized reading' (duration: 240.911843ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:29.346955Z","caller":"traceutil/trace.go:171","msg":"trace[582003449] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:4884; }","duration":"110.776369ms","start":"2026-10-15T11:21:29.236156Z","end":"2026-10-15T11:21:29.346932Z","steps":["trace[582003449] 'agreement among raft nodes before linearized reading' (duration: 110.618395ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:21:29.347036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.415926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-15T11:21:29.347174Z","caller":"traceutil/trace.go:171","msg":"trace[1998792921] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4884; }","duration":"249.713474ms","start":"2026-10-15T11:21:29.09744Z","end":"2026-10-15T11:21:29.347154Z","steps":["trace[1998792921] 'agreement among raft nodes before linearized reading' (duration: 249.159509ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:37.445884Z","caller":"traceutil/trace.go:171","msg":"trace[2112283196] transaction","detail":"{read_only:false; response_revision:5047; number_of_response:1; }","duration":"103.530579ms","start":"2026-10-15T11:21:37.342309Z","end":"2026-10-15T11:21:37.445839Z","steps":["trace[2112283196] 'process raft request' (duration: 103.347444ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:21:40.735019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.622355ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-10-15T11:21:40.735367Z","caller":"traceutil/trace.go:171","msg":"trace[2068724086] linearizableReadLoop","detail":"{readStateIndex:5421; appliedIndex:5419; }","duration":"165.681765ms","start":"2026-10-15T11:21:40.569663Z","end":"2026-10-15T11:21:40.735345Z","steps":["trace[2068724086] 'read index received' (duration: 15.716851ms)","trace[2068724086] 'applied index is now lower than readState.Index' (duration: 149.963704ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:21:40.735459Z","caller":"traceutil/trace.go:171","msg":"trace[603364533] transaction","detail":"{read_only:false; response_revision:5222; number_of_response:1; }","duration":"222.742328ms","start":"2026-10-15T11:21:40.512684Z","end":"2026-10-15T11:21:40.735426Z","steps":["trace[603364533] 'process raft request' (duration: 222.477361ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:21:40.736083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.401665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:24 size:763727"} {"level":"info","ts":"2026-10-15T11:21:40.736147Z","caller":"traceutil/trace.go:171","msg":"trace[1831268789] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:24; response_revision:5222; }","duration":"166.505727ms","start":"2026-10-15T11:21:40.569628Z","end":"2026-10-15T11:21:40.736134Z","steps":["trace[1831268789] 'agreement among raft nodes before linearized reading' (duration: 165.790968ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:43.695086Z","caller":"traceutil/trace.go:171","msg":"trace[1787621871] linearizableReadLoop","detail":"{readStateIndex:5471; appliedIndex:5470; }","duration":"180.204655ms","start":"2026-10-15T11:21:43.514859Z","end":"2026-10-15T11:21:43.695063Z","steps":["trace[1787621871] 'read index received' (duration: 180.00152ms)","trace[1787621871] 'applied index is now lower than readState.Index' (duration: 202.295µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:21:43.695226Z","caller":"traceutil/trace.go:171","msg":"trace[572831679] transaction","detail":"{read_only:false; response_revision:5270; number_of_response:1; }","duration":"181.177601ms","start":"2026-10-15T11:21:43.514038Z","end":"2026-10-15T11:21:43.695215Z","steps":["trace[572831679] 'process raft request' (duration: 180.891654ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:21:43.695391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.332181ms","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-15T11:21:43.695422Z","caller":"traceutil/trace.go:171","msg":"trace[388150417] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5270; }","duration":"161.420523ms","start":"2026-10-15T11:21:43.533993Z","end":"2026-10-15T11:21:43.695413Z","steps":["trace[388150417] 'agreement among raft nodes before linearized reading' (duration: 161.320631ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:21:43.695516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.250683ms","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-15T11:21:43.695544Z","caller":"traceutil/trace.go:171","msg":"trace[617950607] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5270; }","duration":"160.303785ms","start":"2026-10-15T11:21:43.535236Z","end":"2026-10-15T11:21:43.69554Z","steps":["trace[617950607] 'agreement among raft nodes before linearized reading' (duration: 160.247863ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:21:43.69563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.676595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-10-15T11:21:43.695551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.126846ms","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-15T11:21:43.695787Z","caller":"traceutil/trace.go:171","msg":"trace[837534793] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5270; }","duration":"114.411413ms","start":"2026-10-15T11:21:43.581341Z","end":"2026-10-15T11:21:43.695752Z","steps":["trace[837534793] 'agreement among raft nodes before linearized reading' (duration: 114.094235ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:43.695705Z","caller":"traceutil/trace.go:171","msg":"trace[213478383] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5270; }","duration":"160.778987ms","start":"2026-10-15T11:21:43.534913Z","end":"2026-10-15T11:21:43.695692Z","steps":["trace[213478383] 'agreement among raft nodes before linearized reading' (duration: 160.590962ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:21:43.696016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.13985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:821532"} {"level":"info","ts":"2026-10-15T11:21:43.696095Z","caller":"traceutil/trace.go:171","msg":"trace[1224362867] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5270; }","duration":"181.261513ms","start":"2026-10-15T11:21:43.514816Z","end":"2026-10-15T11:21:43.696077Z","steps":["trace[1224362867] 'agreement among raft nodes before linearized reading' (duration: 180.745879ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:46.931159Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2802} {"level":"info","ts":"2026-10-15T11:21:47.011622Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2802,"took":"79.10541ms","hash":3826290070,"current-db-size-bytes":53690368,"current-db-size":"54 MB","current-db-size-in-use-bytes":29335552,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-15T11:21:47.011702Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3826290070,"revision":2802,"compact-revision":-1} {"level":"info","ts":"2026-10-15T11:21:50.100541Z","caller":"traceutil/trace.go:171","msg":"trace[619359008] transaction","detail":"{read_only:false; response_revision:5382; number_of_response:1; }","duration":"112.613156ms","start":"2026-10-15T11:21:49.987887Z","end":"2026-10-15T11:21:50.1005Z","steps":["trace[619359008] 'process raft request' (duration: 64.501097ms)","trace[619359008] 'compare' (duration: 47.991326ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:21:50.530107Z","caller":"traceutil/trace.go:171","msg":"trace[1220138710] transaction","detail":"{read_only:false; response_revision:5385; number_of_response:1; }","duration":"154.816661ms","start":"2026-10-15T11:21:50.375266Z","end":"2026-10-15T11:21:50.530083Z","steps":["trace[1220138710] 'process raft request' (duration: 85.287662ms)","trace[1220138710] 'compare' (duration: 69.425156ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:21:50.635705Z","caller":"traceutil/trace.go:171","msg":"trace[1368754645] transaction","detail":"{read_only:false; response_revision:5386; number_of_response:1; }","duration":"259.991553ms","start":"2026-10-15T11:21:50.375691Z","end":"2026-10-15T11:21:50.635683Z","steps":["trace[1368754645] 'process raft request' (duration: 254.544901ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:50.635952Z","caller":"traceutil/trace.go:171","msg":"trace[1848775492] linearizableReadLoop","detail":"{readStateIndex:5594; appliedIndex:5590; }","duration":"259.10864ms","start":"2026-10-15T11:21:50.376834Z","end":"2026-10-15T11:21:50.635942Z","steps":["trace[1848775492] 'read index received' (duration: 83.861614ms)","trace[1848775492] 'applied index is now lower than readState.Index' (duration: 175.246476ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:21:50.63622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.371846ms","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:2082"} {"level":"warn","ts":"2026-10-15T11:21:50.636258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.54033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.76\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-10-15T11:21:50.636286Z","caller":"traceutil/trace.go:171","msg":"trace[1524956823] range","detail":"{range_begin:/registry/masterleases/162.253.55.76; range_end:; response_count:1; response_revision:5388; }","duration":"168.605232ms","start":"2026-10-15T11:21:50.467672Z","end":"2026-10-15T11:21:50.636277Z","steps":["trace[1524956823] 'agreement among raft nodes before linearized reading' (duration: 168.491229ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:50.636319Z","caller":"traceutil/trace.go:171","msg":"trace[1512829797] 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:5388; }","duration":"259.469069ms","start":"2026-10-15T11:21:50.376797Z","end":"2026-10-15T11:21:50.636266Z","steps":["trace[1512829797] 'agreement among raft nodes before linearized reading' (duration: 259.304425ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:50.636445Z","caller":"traceutil/trace.go:171","msg":"trace[896587540] transaction","detail":"{read_only:false; response_revision:5387; number_of_response:1; }","duration":"260.418735ms","start":"2026-10-15T11:21:50.376019Z","end":"2026-10-15T11:21:50.636438Z","steps":["trace[896587540] 'process raft request' (duration: 259.617004ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:21:50.636469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.093266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/prometheus-pushgateway\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:21:50.636496Z","caller":"traceutil/trace.go:171","msg":"trace[1741919302] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/prometheus-pushgateway; range_end:; response_count:0; response_revision:5388; }","duration":"119.165998ms","start":"2026-10-15T11:21:50.51732Z","end":"2026-10-15T11:21:50.636486Z","steps":["trace[1741919302] 'agreement among raft nodes before linearized reading' (duration: 119.123627ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:50.636593Z","caller":"traceutil/trace.go:171","msg":"trace[747905257] transaction","detail":"{read_only:false; response_revision:5388; number_of_response:1; }","duration":"259.850789ms","start":"2026-10-15T11:21:50.376724Z","end":"2026-10-15T11:21:50.636575Z","steps":["trace[747905257] 'process raft request' (duration: 259.12338ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:21:50.636657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.077452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:21:50.636678Z","caller":"traceutil/trace.go:171","msg":"trace[837874752] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:5388; }","duration":"133.129653ms","start":"2026-10-15T11:21:50.503542Z","end":"2026-10-15T11:21:50.636672Z","steps":["trace[837874752] 'agreement among raft nodes before linearized reading' (duration: 133.089262ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:56.63844Z","caller":"traceutil/trace.go:171","msg":"trace[336545839] transaction","detail":"{read_only:false; response_revision:5503; number_of_response:1; }","duration":"159.431562ms","start":"2026-10-15T11:21:56.478981Z","end":"2026-10-15T11:21:56.638413Z","steps":["trace[336545839] 'process raft request' (duration: 159.36154ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:21:56.638461Z","caller":"traceutil/trace.go:171","msg":"trace[1759812519] transaction","detail":"{read_only:false; response_revision:5502; number_of_response:1; }","duration":"160.784537ms","start":"2026-10-15T11:21:56.477645Z","end":"2026-10-15T11:21:56.63843Z","steps":["trace[1759812519] 'process raft request' (duration: 83.180117ms)","trace[1759812519] 'compare' (duration: 77.362064ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:22:04.696176Z","caller":"traceutil/trace.go:171","msg":"trace[1248354741] transaction","detail":"{read_only:false; response_revision:5633; number_of_response:1; }","duration":"232.298783ms","start":"2026-10-15T11:22:04.463848Z","end":"2026-10-15T11:22:04.696147Z","steps":["trace[1248354741] 'process raft request' (duration: 232.121019ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:22:05.048752Z","caller":"traceutil/trace.go:171","msg":"trace[416478167] transaction","detail":"{read_only:false; response_revision:5634; number_of_response:1; }","duration":"205.89434ms","start":"2026-10-15T11:22:04.842814Z","end":"2026-10-15T11:22:05.048708Z","steps":["trace[416478167] 'process raft request' (duration: 108.874455ms)","trace[416478167] 'compare' (duration: 96.82558ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:22:06.447142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.151683ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-15T11:22:06.447256Z","caller":"traceutil/trace.go:171","msg":"trace[1111963842] linearizableReadLoop","detail":"{readStateIndex:5850; appliedIndex:5849; }","duration":"601.399654ms","start":"2026-10-15T11:22:05.845837Z","end":"2026-10-15T11:22:06.447237Z","steps":["trace[1111963842] 'read index received' (duration: 89.186699ms)","trace[1111963842] 'applied index is now lower than readState.Index' (duration: 512.211135ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:22:06.447631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.778694ms","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-15T11:22:06.447666Z","caller":"traceutil/trace.go:171","msg":"trace[1820622225] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5638; }","duration":"601.823815ms","start":"2026-10-15T11:22:05.84583Z","end":"2026-10-15T11:22:06.447654Z","steps":["trace[1820622225] 'agreement among raft nodes before linearized reading' (duration: 601.64165ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:22:06.447699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:22:05.845769Z","time spent":"601.921648ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-15T11:22:06.466932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.911671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-10-15T11:22:06.466928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.301219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-10-15T11:22:06.466989Z","caller":"traceutil/trace.go:171","msg":"trace[1443125675] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5639; }","duration":"471.013804ms","start":"2026-10-15T11:22:05.995961Z","end":"2026-10-15T11:22:06.466975Z","steps":["trace[1443125675] 'agreement among raft nodes before linearized reading' (duration: 470.84636ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:22:06.466995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.516195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b7ab7a2f-bfb6-4bf1-adf4-5c5c04463da5\" ","response":"range_response_count:1 size:3762"} {"level":"info","ts":"2026-10-15T11:22:06.467043Z","caller":"traceutil/trace.go:171","msg":"trace[1780596034] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5639; }","duration":"546.500684ms","start":"2026-10-15T11:22:05.920514Z","end":"2026-10-15T11:22:06.467015Z","steps":["trace[1780596034] 'agreement among raft nodes before linearized reading' (duration: 546.226357ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:22:06.467018Z","caller":"traceutil/trace.go:171","msg":"trace[1653226842] transaction","detail":"{read_only:false; response_revision:5639; number_of_response:1; }","duration":"274.074999ms","start":"2026-10-15T11:22:06.192885Z","end":"2026-10-15T11:22:06.46696Z","steps":["trace[1653226842] 'process raft request' (duration: 273.576325ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:22:06.467107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:22:05.920488Z","time spent":"546.605507ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-15T11:22:06.467125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.211936ms","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":"warn","ts":"2026-10-15T11:22:06.467107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.027451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:22:06.467158Z","caller":"traceutil/trace.go:171","msg":"trace[1744460617] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5639; }","duration":"472.268447ms","start":"2026-10-15T11:22:05.994881Z","end":"2026-10-15T11:22:06.467149Z","steps":["trace[1744460617] 'agreement among raft nodes before linearized reading' (duration: 472.182484ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:22:06.467153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.218756ms","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":"warn","ts":"2026-10-15T11:22:06.467184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:22:05.994866Z","time spent":"472.311648ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-10-15T11:22:06.46719Z","caller":"traceutil/trace.go:171","msg":"trace[1346848400] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5639; }","duration":"122.146694ms","start":"2026-10-15T11:22:06.345022Z","end":"2026-10-15T11:22:06.467169Z","steps":["trace[1346848400] 'agreement among raft nodes before linearized reading' (duration: 122.017631ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:22:06.467108Z","caller":"traceutil/trace.go:171","msg":"trace[132844677] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b7ab7a2f-bfb6-4bf1-adf4-5c5c04463da5; range_end:; response_count:1; response_revision:5639; }","duration":"315.68472ms","start":"2026-10-15T11:22:06.151397Z","end":"2026-10-15T11:22:06.467081Z","steps":["trace[132844677] 'agreement among raft nodes before linearized reading' (duration: 315.371862ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:22:06.46723Z","caller":"traceutil/trace.go:171","msg":"trace[2127598958] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5639; }","duration":"464.313268ms","start":"2026-10-15T11:22:06.002893Z","end":"2026-10-15T11:22:06.467207Z","steps":["trace[2127598958] 'agreement among raft nodes before linearized reading' (duration: 464.089282ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:22:06.467284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:22:06.00286Z","time spent":"464.412191ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-10-15T11:22:06.467032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:22:05.995929Z","time spent":"471.094316ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-15T11:22:06.467317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:22:06.151376Z","time spent":"315.900156ms","remote":"127.0.0.1:45168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3785,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b7ab7a2f-bfb6-4bf1-adf4-5c5c04463da5\" "} {"level":"info","ts":"2026-10-15T11:22:08.700169Z","caller":"traceutil/trace.go:171","msg":"trace[1321923078] linearizableReadLoop","detail":"{readStateIndex:5879; appliedIndex:5878; }","duration":"195.238372ms","start":"2026-10-15T11:22:08.504907Z","end":"2026-10-15T11:22:08.700145Z","steps":["trace[1321923078] 'read index received' (duration: 151.232497ms)","trace[1321923078] 'applied index is now lower than readState.Index' (duration: 44.004584ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:22:08.700292Z","caller":"traceutil/trace.go:171","msg":"trace[207361212] transaction","detail":"{read_only:false; response_revision:5667; number_of_response:1; }","duration":"203.857407ms","start":"2026-10-15T11:22:08.496419Z","end":"2026-10-15T11:22:08.700276Z","steps":["trace[207361212] 'process raft request' (duration: 159.721679ms)","trace[207361212] 'compare' (duration: 43.894902ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:22:08.700457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.326064ms","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-15T11:22:08.700573Z","caller":"traceutil/trace.go:171","msg":"trace[2091539986] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5667; }","duration":"195.464627ms","start":"2026-10-15T11:22:08.505091Z","end":"2026-10-15T11:22:08.700556Z","steps":["trace[2091539986] 'agreement among raft nodes before linearized reading' (duration: 195.280222ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:22:08.700688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.587984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b7ab7a2f-bfb6-4bf1-adf4-5c5c04463da5\" ","response":"range_response_count:1 size:3948"} {"level":"info","ts":"2026-10-15T11:22:08.700736Z","caller":"traceutil/trace.go:171","msg":"trace[1215370138] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b7ab7a2f-bfb6-4bf1-adf4-5c5c04463da5; range_end:; response_count:1; response_revision:5667; }","duration":"186.651776ms","start":"2026-10-15T11:22:08.514072Z","end":"2026-10-15T11:22:08.700724Z","steps":["trace[1215370138] 'agreement among raft nodes before linearized reading' (duration: 186.511992ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:22:08.700721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.787996ms","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":"warn","ts":"2026-10-15T11:22:08.700753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.335714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-10-15T11:22:08.700809Z","caller":"traceutil/trace.go:171","msg":"trace[1915477661] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5667; }","duration":"195.906768ms","start":"2026-10-15T11:22:08.504879Z","end":"2026-10-15T11:22:08.700786Z","steps":["trace[1915477661] 'agreement among raft nodes before linearized reading' (duration: 195.748204ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:22:08.700831Z","caller":"traceutil/trace.go:171","msg":"trace[1458147390] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5667; }","duration":"195.418336ms","start":"2026-10-15T11:22:08.505387Z","end":"2026-10-15T11:22:08.700805Z","steps":["trace[1458147390] 'agreement among raft nodes before linearized reading' (duration: 195.299333ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:22:08.70137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.179947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-10-15T11:22:08.701461Z","caller":"traceutil/trace.go:171","msg":"trace[350289692] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5667; }","duration":"172.294219ms","start":"2026-10-15T11:22:08.529147Z","end":"2026-10-15T11:22:08.701441Z","steps":["trace[350289692] 'agreement among raft nodes before linearized reading' (duration: 171.427997ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:22:22.674389Z","caller":"traceutil/trace.go:171","msg":"trace[2006071416] linearizableReadLoop","detail":"{readStateIndex:6074; appliedIndex:6073; }","duration":"100.619789ms","start":"2026-10-15T11:22:22.573746Z","end":"2026-10-15T11:22:22.674366Z","steps":["trace[2006071416] 'read index received' (duration: 100.374773ms)","trace[2006071416] 'applied index is now lower than readState.Index' (duration: 244.186µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:22:22.674436Z","caller":"traceutil/trace.go:171","msg":"trace[37702354] transaction","detail":"{read_only:false; response_revision:5856; number_of_response:1; }","duration":"143.466103ms","start":"2026-10-15T11:22:22.530949Z","end":"2026-10-15T11:22:22.674415Z","steps":["trace[37702354] 'process raft request' (duration: 143.244507ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:22:22.674772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.991199ms","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-15T11:22:22.67489Z","caller":"traceutil/trace.go:171","msg":"trace[2060533002] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5856; }","duration":"101.152774ms","start":"2026-10-15T11:22:22.573695Z","end":"2026-10-15T11:22:22.674848Z","steps":["trace[2060533002] 'agreement among raft nodes before linearized reading' (duration: 100.786904ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:22:22.802656Z","caller":"traceutil/trace.go:171","msg":"trace[1946321429] transaction","detail":"{read_only:false; response_revision:5857; number_of_response:1; }","duration":"122.773691ms","start":"2026-10-15T11:22:22.679852Z","end":"2026-10-15T11:22:22.802626Z","steps":["trace[1946321429] 'process raft request' (duration: 106.324149ms)","trace[1946321429] 'compare' (duration: 16.296928ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:22:22.816372Z","caller":"traceutil/trace.go:171","msg":"trace[328903218] transaction","detail":"{read_only:false; response_revision:5858; number_of_response:1; }","duration":"127.797772ms","start":"2026-10-15T11:22:22.688474Z","end":"2026-10-15T11:22:22.816272Z","steps":["trace[328903218] 'process raft request' (duration: 127.502475ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:22:22.940923Z","caller":"traceutil/trace.go:171","msg":"trace[1862909515] transaction","detail":"{read_only:false; response_revision:5862; number_of_response:1; }","duration":"116.227218ms","start":"2026-10-15T11:22:22.824672Z","end":"2026-10-15T11:22:22.940899Z","steps":["trace[1862909515] 'process raft request' (duration: 116.139516ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:22:22.941057Z","caller":"traceutil/trace.go:171","msg":"trace[33123343] transaction","detail":"{read_only:false; response_revision:5860; number_of_response:1; }","duration":"119.785741ms","start":"2026-10-15T11:22:22.821232Z","end":"2026-10-15T11:22:22.941018Z","steps":["trace[33123343] 'process raft request' (duration: 111.616877ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:22:22.941059Z","caller":"traceutil/trace.go:171","msg":"trace[1467024720] transaction","detail":"{read_only:false; response_revision:5861; number_of_response:1; }","duration":"116.521297ms","start":"2026-10-15T11:22:22.824469Z","end":"2026-10-15T11:22:22.940991Z","steps":["trace[1467024720] 'process raft request' (duration: 116.27862ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:22:22.941389Z","caller":"traceutil/trace.go:171","msg":"trace[1099133279] transaction","detail":"{read_only:false; response_revision:5863; number_of_response:1; }","duration":"116.387272ms","start":"2026-10-15T11:22:22.824975Z","end":"2026-10-15T11:22:22.941363Z","steps":["trace[1099133279] 'process raft request' (duration: 115.883939ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:22:22.941495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.661186ms","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-15T11:22:22.941565Z","caller":"traceutil/trace.go:171","msg":"trace[1337501035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5864; }","duration":"109.763409ms","start":"2026-10-15T11:22:22.831767Z","end":"2026-10-15T11:22:22.941531Z","steps":["trace[1337501035] 'agreement among raft nodes before linearized reading' (duration: 109.595314ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:22:22.94164Z","caller":"traceutil/trace.go:171","msg":"trace[1564779664] transaction","detail":"{read_only:false; response_revision:5864; number_of_response:1; }","duration":"115.618793ms","start":"2026-10-15T11:22:22.825983Z","end":"2026-10-15T11:22:22.941602Z","steps":["trace[1564779664] 'process raft request' (duration: 115.15177ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:26:46.939798Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5334} {"level":"info","ts":"2026-10-15T11:26:47.031952Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5334,"took":"90.569643ms","hash":716411275,"current-db-size-bytes":53690368,"current-db-size":"54 MB","current-db-size-in-use-bytes":24875008,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-10-15T11:26:47.032021Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":716411275,"revision":5334,"compact-revision":2802}