{"level":"warn","ts":"2026-07-21T13:21:24.940822Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-21T13:21:24.94092Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.25:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.25:2380","--initial-cluster=instance=https://199.19.213.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.25:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-21T13:21:24.94099Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-21T13:21:24.941003Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.25:2380"]} {"level":"info","ts":"2026-07-21T13:21:24.941028Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-21T13:21:24.941665Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.25:2379"]} {"level":"info","ts":"2026-07-21T13:21:24.941745Z","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":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.25:2380"],"listen-peer-urls":["https://199.19.213.25:2380"],"advertise-client-urls":["https://199.19.213.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.25:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-21T13:21:24.946356Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.410632ms"} {"level":"info","ts":"2026-07-21T13:21:24.956592Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9bd4db28c48efaf1","cluster-id":"b621f59192c78404"} {"level":"info","ts":"2026-07-21T13:21:24.956753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 switched to configuration voters=()"} {"level":"info","ts":"2026-07-21T13:21:24.956828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became follower at term 0"} {"level":"info","ts":"2026-07-21T13:21:24.956882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9bd4db28c48efaf1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-21T13:21:24.956918Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became follower at term 1"} {"level":"info","ts":"2026-07-21T13:21:24.957083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 switched to configuration voters=(11228840739084368625)"} {"level":"warn","ts":"2026-07-21T13:21:24.965298Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-21T13:21:24.966921Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-21T13:21:24.968562Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-21T13:21:24.971742Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9bd4db28c48efaf1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-21T13:21:24.972686Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-21T13:21:24.972816Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-21T13:21:24.972899Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-21T13:21:24.973065Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9bd4db28c48efaf1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-21T13:21:24.97377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 switched to configuration voters=(11228840739084368625)"} {"level":"info","ts":"2026-07-21T13:21:24.974001Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b621f59192c78404","local-member-id":"9bd4db28c48efaf1","added-peer-id":"9bd4db28c48efaf1","added-peer-peer-urls":["https://199.19.213.25:2380"]} {"level":"info","ts":"2026-07-21T13:21:24.975752Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-21T13:21:24.975858Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.25:2380"} {"level":"info","ts":"2026-07-21T13:21:24.975888Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.25:2380"} {"level":"info","ts":"2026-07-21T13:21:24.975928Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9bd4db28c48efaf1","initial-advertise-peer-urls":["https://199.19.213.25:2380"],"listen-peer-urls":["https://199.19.213.25:2380"],"advertise-client-urls":["https://199.19.213.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-21T13:21:24.975962Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-21T13:21:25.658679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 is starting a new election at term 1"} {"level":"info","ts":"2026-07-21T13:21:25.658739Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-21T13:21:25.658765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 received MsgPreVoteResp from 9bd4db28c48efaf1 at term 1"} {"level":"info","ts":"2026-07-21T13:21:25.658786Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became candidate at term 2"} {"level":"info","ts":"2026-07-21T13:21:25.658807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 received MsgVoteResp from 9bd4db28c48efaf1 at term 2"} {"level":"info","ts":"2026-07-21T13:21:25.65883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became leader at term 2"} {"level":"info","ts":"2026-07-21T13:21:25.658849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9bd4db28c48efaf1 elected leader 9bd4db28c48efaf1 at term 2"} {"level":"info","ts":"2026-07-21T13:21:25.659987Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9bd4db28c48efaf1","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.25:2379]}","request-path":"/0/members/9bd4db28c48efaf1/attributes","cluster-id":"b621f59192c78404","publish-timeout":"7s"} {"level":"info","ts":"2026-07-21T13:21:25.660167Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-21T13:21:25.660205Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-21T13:21:25.66048Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T13:21:25.661542Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b621f59192c78404","local-member-id":"9bd4db28c48efaf1","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T13:21:25.661663Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T13:21:25.661697Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T13:21:25.663386Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-21T13:21:25.663825Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-21T13:21:25.663861Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-21T13:21:25.668869Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.25:2379"} {"level":"info","ts":"2026-07-21T13:21:30.332618Z","caller":"traceutil/trace.go:171","msg":"trace[664638801] transaction","detail":"{read_only:false; number_of_response:0; response_revision:273; }","duration":"102.41183ms","start":"2026-07-21T13:21:30.23018Z","end":"2026-07-21T13:21:30.332592Z","steps":["trace[664638801] 'process raft request' (duration: 102.204795ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:21:35.556767Z","caller":"traceutil/trace.go:171","msg":"trace[378376308] linearizableReadLoop","detail":"{readStateIndex:371; appliedIndex:369; }","duration":"102.021439ms","start":"2026-07-21T13:21:35.454725Z","end":"2026-07-21T13:21:35.556747Z","steps":["trace[378376308] 'read index received' (duration: 38.054529ms)","trace[378376308] 'applied index is now lower than readState.Index' (duration: 63.9655ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:21:35.556893Z","caller":"traceutil/trace.go:171","msg":"trace[319428582] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"123.803495ms","start":"2026-07-21T13:21:35.433079Z","end":"2026-07-21T13:21:35.556882Z","steps":["trace[319428582] 'process raft request' (duration: 123.62329ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:21:35.556893Z","caller":"traceutil/trace.go:171","msg":"trace[1012725132] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"123.879317ms","start":"2026-07-21T13:21:35.432985Z","end":"2026-07-21T13:21:35.556865Z","steps":["trace[1012725132] 'process raft request' (duration: 59.801744ms)","trace[1012725132] 'compare' (duration: 63.795986ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:21:35.557177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.43555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-07-21T13:21:35.557254Z","caller":"traceutil/trace.go:171","msg":"trace[1964890406] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:358; }","duration":"102.554963ms","start":"2026-07-21T13:21:35.454684Z","end":"2026-07-21T13:21:35.557239Z","steps":["trace[1964890406] 'agreement among raft nodes before linearized reading' (duration: 102.42383ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:21:39.330287Z","caller":"traceutil/trace.go:171","msg":"trace[1574733033] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"356.505286ms","start":"2026-07-21T13:21:38.973754Z","end":"2026-07-21T13:21:39.330259Z","steps":["trace[1574733033] 'process raft request' (duration: 356.328051ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:21:39.331054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:21:38.973728Z","time spent":"356.65661ms","remote":"127.0.0.1:48230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:21:39.76234Z","caller":"traceutil/trace.go:171","msg":"trace[1065268075] linearizableReadLoop","detail":"{readStateIndex:419; appliedIndex:418; }","duration":"230.108554ms","start":"2026-07-21T13:21:39.532173Z","end":"2026-07-21T13:21:39.762282Z","steps":["trace[1065268075] 'read index received' (duration: 196.762296ms)","trace[1065268075] 'applied index is now lower than readState.Index' (duration: 33.344978ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:21:39.762384Z","caller":"traceutil/trace.go:171","msg":"trace[900752513] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"427.755641ms","start":"2026-07-21T13:21:39.334601Z","end":"2026-07-21T13:21:39.762357Z","steps":["trace[900752513] 'process raft request' (duration: 394.32224ms)","trace[900752513] 'compare' (duration: 33.218616ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:21:39.76261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.697548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-21T13:21:39.762574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.382352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4322"} {"level":"info","ts":"2026-07-21T13:21:39.762653Z","caller":"traceutil/trace.go:171","msg":"trace[1018803411] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:404; }","duration":"102.80702ms","start":"2026-07-21T13:21:39.659833Z","end":"2026-07-21T13:21:39.76264Z","steps":["trace[1018803411] 'agreement among raft nodes before linearized reading' (duration: 102.704498ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:21:39.762671Z","caller":"traceutil/trace.go:171","msg":"trace[704383321] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:404; }","duration":"230.519586ms","start":"2026-07-21T13:21:39.532134Z","end":"2026-07-21T13:21:39.762653Z","steps":["trace[704383321] 'agreement among raft nodes before linearized reading' (duration: 230.307529ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:21:39.762686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:21:39.334578Z","time spent":"427.984299ms","remote":"127.0.0.1:48230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:21:40.72402Z","caller":"traceutil/trace.go:171","msg":"trace[2069403036] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"194.921668ms","start":"2026-07-21T13:21:40.529076Z","end":"2026-07-21T13:21:40.723998Z","steps":["trace[2069403036] 'process raft request' (duration: 186.058002ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:21:50.791158Z","caller":"traceutil/trace.go:171","msg":"trace[1606587276] linearizableReadLoop","detail":"{readStateIndex:483; appliedIndex:482; }","duration":"339.495162ms","start":"2026-07-21T13:21:50.451639Z","end":"2026-07-21T13:21:50.791134Z","steps":["trace[1606587276] 'read index received' (duration: 339.274367ms)","trace[1606587276] 'applied index is now lower than readState.Index' (duration: 219.815µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:21:50.791251Z","caller":"traceutil/trace.go:171","msg":"trace[1332038525] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"551.557786ms","start":"2026-07-21T13:21:50.239655Z","end":"2026-07-21T13:21:50.791213Z","steps":["trace[1332038525] 'process raft request' (duration: 551.339541ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:21:50.79139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.979574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-21T13:21:50.791416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:21:50.239637Z","time spent":"551.695891ms","remote":"127.0.0.1:48230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:21:50.791447Z","caller":"traceutil/trace.go:171","msg":"trace[520778531] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:465; }","duration":"132.073206ms","start":"2026-07-21T13:21:50.659359Z","end":"2026-07-21T13:21:50.791432Z","steps":["trace[520778531] 'agreement among raft nodes before linearized reading' (duration: 131.974053ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:21:50.791981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.337084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-21T13:21:50.792047Z","caller":"traceutil/trace.go:171","msg":"trace[641454004] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:465; }","duration":"340.442737ms","start":"2026-07-21T13:21:50.45159Z","end":"2026-07-21T13:21:50.792033Z","steps":["trace[641454004] 'agreement among raft nodes before linearized reading' (duration: 339.653176ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:21:50.792083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:21:50.451571Z","time spent":"340.504589ms","remote":"127.0.0.1:48230","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-07-21T13:22:02.424227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.763824ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-21T13:22:02.424788Z","caller":"traceutil/trace.go:171","msg":"trace[940977445] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"380.15639ms","start":"2026-07-21T13:22:02.044585Z","end":"2026-07-21T13:22:02.424741Z","steps":["trace[940977445] 'process raft request' (duration: 379.882053ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:22:02.42474Z","caller":"traceutil/trace.go:171","msg":"trace[1182498405] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"388.633975ms","start":"2026-07-21T13:22:02.035996Z","end":"2026-07-21T13:22:02.42463Z","steps":["trace[1182498405] 'process raft request' (duration: 149.185553ms)","trace[1182498405] 'compare' (duration: 238.56639ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:22:02.425754Z","caller":"traceutil/trace.go:171","msg":"trace[589855319] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"364.387478ms","start":"2026-07-21T13:22:02.06133Z","end":"2026-07-21T13:22:02.425718Z","steps":["trace[589855319] 'process raft request' (duration: 363.351061ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:22:02.424903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:02.044557Z","time spent":"380.278612ms","remote":"127.0.0.1:48010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29461,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T13:22:02.426335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:02.061314Z","time spent":"364.941802ms","remote":"127.0.0.1:48010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-21T13:22:02.426617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:02.03598Z","time spent":"390.38091ms","remote":"127.0.0.1:48010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31102,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:22:08.779037Z","caller":"traceutil/trace.go:171","msg":"trace[827360031] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:657; }","duration":"120.178442ms","start":"2026-07-21T13:22:08.65882Z","end":"2026-07-21T13:22:08.778999Z","steps":["trace[827360031] 'read index received' (duration: 80.374958ms)","trace[827360031] 'applied index is now lower than readState.Index' (duration: 39.801844ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:22:08.779102Z","caller":"traceutil/trace.go:171","msg":"trace[214898108] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"259.934864ms","start":"2026-07-21T13:22:08.519136Z","end":"2026-07-21T13:22:08.779071Z","steps":["trace[214898108] 'process raft request' (duration: 220.047518ms)","trace[214898108] 'compare' (duration: 39.621779ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:22:08.779223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.380848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:22:08.779271Z","caller":"traceutil/trace.go:171","msg":"trace[1841229083] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"120.46834ms","start":"2026-07-21T13:22:08.658787Z","end":"2026-07-21T13:22:08.779255Z","steps":["trace[1841229083] 'agreement among raft nodes before linearized reading' (duration: 120.331265ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:22:09.097094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.455057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-21T13:22:09.097167Z","caller":"traceutil/trace.go:171","msg":"trace[1373956725] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:634; }","duration":"103.58449ms","start":"2026-07-21T13:22:08.993566Z","end":"2026-07-21T13:22:09.097151Z","steps":["trace[1373956725] 'range keys from in-memory index tree' (duration: 103.287703ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:22:09.097883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.853182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-21T13:22:09.098067Z","caller":"traceutil/trace.go:171","msg":"trace[828398967] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:634; }","duration":"103.146309ms","start":"2026-07-21T13:22:08.994853Z","end":"2026-07-21T13:22:09.097999Z","steps":["trace[828398967] 'range keys from in-memory index tree' (duration: 102.289407ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:22:10.033151Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18082409371754291852,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-21T13:22:10.2713Z","caller":"traceutil/trace.go:171","msg":"trace[1662548728] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"985.960199ms","start":"2026-07-21T13:22:09.285309Z","end":"2026-07-21T13:22:10.271269Z","steps":["trace[1662548728] 'process raft request' (duration: 974.823765ms)","trace[1662548728] 'compare' (duration: 10.58166ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:22:10.271454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:09.285272Z","time spent":"986.107933ms","remote":"127.0.0.1:48152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:22:10.273218Z","caller":"traceutil/trace.go:171","msg":"trace[1821165562] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:661; }","duration":"740.720049ms","start":"2026-07-21T13:22:09.532474Z","end":"2026-07-21T13:22:10.273194Z","steps":["trace[1821165562] 'read index received' (duration: 727.759468ms)","trace[1821165562] 'applied index is now lower than readState.Index' (duration: 12.959581ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:22:10.273395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.928855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-21T13:22:10.273445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.754513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:22:10.273455Z","caller":"traceutil/trace.go:171","msg":"trace[1995623787] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"958.984411ms","start":"2026-07-21T13:22:09.314322Z","end":"2026-07-21T13:22:10.273306Z","steps":["trace[1995623787] 'process raft request' (duration: 958.763426ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:22:10.273463Z","caller":"traceutil/trace.go:171","msg":"trace[2121300162] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:639; }","duration":"613.804664ms","start":"2026-07-21T13:22:09.659649Z","end":"2026-07-21T13:22:10.273454Z","steps":["trace[2121300162] 'agreement among raft nodes before linearized reading' (duration: 613.781993ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:22:10.273505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:09.659629Z","time spent":"613.869956ms","remote":"127.0.0.1:47934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-21T13:22:10.273554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:09.314291Z","time spent":"959.195947ms","remote":"127.0.0.1:48212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-21T13:22:10.273593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.159822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-21T13:22:10.273577Z","caller":"traceutil/trace.go:171","msg":"trace[919359143] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:639; }","duration":"741.007597ms","start":"2026-07-21T13:22:09.532404Z","end":"2026-07-21T13:22:10.273411Z","steps":["trace[919359143] 'agreement among raft nodes before linearized reading' (duration: 740.905204ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:22:10.273655Z","caller":"traceutil/trace.go:171","msg":"trace[985476264] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:639; }","duration":"293.275755ms","start":"2026-07-21T13:22:09.980352Z","end":"2026-07-21T13:22:10.273628Z","steps":["trace[985476264] 'agreement among raft nodes before linearized reading' (duration: 293.107661ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:22:10.273688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:09.532308Z","time spent":"741.346985ms","remote":"127.0.0.1:48230","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":"info","ts":"2026-07-21T13:22:11.63118Z","caller":"traceutil/trace.go:171","msg":"trace[720128492] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"224.78747ms","start":"2026-07-21T13:22:11.406369Z","end":"2026-07-21T13:22:11.631156Z","steps":["trace[720128492] 'process raft request' (duration: 224.509472ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:22:27.381276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"921.48738ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-21T13:22:27.381439Z","caller":"traceutil/trace.go:171","msg":"trace[1519565282] linearizableReadLoop","detail":"{readStateIndex:826; appliedIndex:825; }","duration":"942.310492ms","start":"2026-07-21T13:22:26.439105Z","end":"2026-07-21T13:22:27.381415Z","steps":["trace[1519565282] 'read index received' (duration: 20.502453ms)","trace[1519565282] 'applied index is now lower than readState.Index' (duration: 921.806029ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:22:27.381451Z","caller":"traceutil/trace.go:171","msg":"trace[363271464] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"974.252501ms","start":"2026-07-21T13:22:26.407166Z","end":"2026-07-21T13:22:27.381418Z","steps":["trace[363271464] 'process raft request' (duration: 52.495104ms)","trace[363271464] 'compare' (duration: 921.13394ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:22:27.381654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"942.547699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-21T13:22:27.381689Z","caller":"traceutil/trace.go:171","msg":"trace[572928506] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:798; }","duration":"942.612541ms","start":"2026-07-21T13:22:26.439066Z","end":"2026-07-21T13:22:27.381678Z","steps":["trace[572928506] 'agreement among raft nodes before linearized reading' (duration: 942.469667ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:22:27.381701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:26.407144Z","time spent":"974.460056ms","remote":"127.0.0.1:48152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4024,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T13:22:27.381726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:26.43905Z","time spent":"942.665883ms","remote":"127.0.0.1:48036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":93,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-07-21T13:22:27.381878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"916.464832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:22:27.381941Z","caller":"traceutil/trace.go:171","msg":"trace[27017149] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:798; }","duration":"916.575545ms","start":"2026-07-21T13:22:26.465349Z","end":"2026-07-21T13:22:27.381924Z","steps":["trace[27017149] 'agreement among raft nodes before linearized reading' (duration: 916.461891ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:22:27.381961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.528262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-21T13:22:27.381975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:26.465328Z","time spent":"916.639497ms","remote":"127.0.0.1:48206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-07-21T13:22:27.382Z","caller":"traceutil/trace.go:171","msg":"trace[1484910352] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:798; }","duration":"483.596973ms","start":"2026-07-21T13:22:26.898395Z","end":"2026-07-21T13:22:27.381992Z","steps":["trace[1484910352] 'agreement among raft nodes before linearized reading' (duration: 483.533412ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:22:27.381991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.053968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-21T13:22:27.382024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:26.898379Z","time spent":"483.639115ms","remote":"127.0.0.1:48260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":29,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"info","ts":"2026-07-21T13:22:27.382034Z","caller":"traceutil/trace.go:171","msg":"trace[790798517] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:798; }","duration":"722.139ms","start":"2026-07-21T13:22:26.659883Z","end":"2026-07-21T13:22:27.382022Z","steps":["trace[790798517] 'agreement among raft nodes before linearized reading' (duration: 722.068908ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:22:27.382046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.609679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-21T13:22:27.382063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:26.659859Z","time spent":"722.198042ms","remote":"127.0.0.1:47934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-21T13:22:27.382093Z","caller":"traceutil/trace.go:171","msg":"trace[22743400] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:798; }","duration":"162.688382ms","start":"2026-07-21T13:22:27.219388Z","end":"2026-07-21T13:22:27.382076Z","steps":["trace[22743400] 'agreement among raft nodes before linearized reading' (duration: 162.539738ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:22:27.382142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.200332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-21T13:22:27.382208Z","caller":"traceutil/trace.go:171","msg":"trace[1525397949] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:798; }","duration":"137.320815ms","start":"2026-07-21T13:22:27.244867Z","end":"2026-07-21T13:22:27.382188Z","steps":["trace[1525397949] 'agreement among raft nodes before linearized reading' (duration: 137.089208ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:22:27.910981Z","caller":"traceutil/trace.go:171","msg":"trace[506013087] linearizableReadLoop","detail":"{readStateIndex:828; appliedIndex:826; }","duration":"474.436211ms","start":"2026-07-21T13:22:27.436524Z","end":"2026-07-21T13:22:27.910961Z","steps":["trace[506013087] 'read index received' (duration: 440.111788ms)","trace[506013087] 'applied index is now lower than readState.Index' (duration: 34.323563ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:22:27.911269Z","caller":"traceutil/trace.go:171","msg":"trace[2060472198] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"523.47074ms","start":"2026-07-21T13:22:27.387772Z","end":"2026-07-21T13:22:27.911243Z","steps":["trace[2060472198] 'process raft request' (duration: 523.078869ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:22:27.911365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.825512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:22:27.911443Z","caller":"traceutil/trace.go:171","msg":"trace[958526746] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:800; }","duration":"474.954446ms","start":"2026-07-21T13:22:27.436473Z","end":"2026-07-21T13:22:27.911427Z","steps":["trace[958526746] 'agreement among raft nodes before linearized reading' (duration: 474.790301ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:22:27.911493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:27.436455Z","time spent":"475.028077ms","remote":"127.0.0.1:48052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-07-21T13:22:27.911442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:27.387761Z","time spent":"523.595733ms","remote":"127.0.0.1:48230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:22:27.91127Z","caller":"traceutil/trace.go:171","msg":"trace[880069974] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"523.912232ms","start":"2026-07-21T13:22:27.387327Z","end":"2026-07-21T13:22:27.911239Z","steps":["trace[880069974] 'process raft request' (duration: 489.269949ms)","trace[880069974] 'compare' (duration: 33.747208ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:22:27.911766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:22:27.387311Z","time spent":"524.391734ms","remote":"127.0.0.1:48230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:22:52.662875Z","caller":"traceutil/trace.go:171","msg":"trace[1150280000] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"117.15402ms","start":"2026-07-21T13:22:52.545702Z","end":"2026-07-21T13:22:52.662856Z","steps":["trace[1150280000] 'process raft request' (duration: 80.888074ms)","trace[1150280000] 'compare' (duration: 36.006509ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:23:02.101115Z","caller":"traceutil/trace.go:171","msg":"trace[1375865986] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"313.490346ms","start":"2026-07-21T13:23:01.787601Z","end":"2026-07-21T13:23:02.101091Z","steps":["trace[1375865986] 'process raft request' (duration: 313.366773ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:02.101271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:01.787578Z","time spent":"313.60356ms","remote":"127.0.0.1:48230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:23:39.163737Z","caller":"traceutil/trace.go:171","msg":"trace[530953240] linearizableReadLoop","detail":"{readStateIndex:1237; appliedIndex:1236; }","duration":"130.347768ms","start":"2026-07-21T13:23:39.033356Z","end":"2026-07-21T13:23:39.163704Z","steps":["trace[530953240] 'read index received' (duration: 129.68215ms)","trace[530953240] 'applied index is now lower than readState.Index' (duration: 664.608µs)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:23:39.163922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.559973ms","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-07-21T13:23:39.163951Z","caller":"traceutil/trace.go:171","msg":"trace[71430271] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1191; }","duration":"130.635075ms","start":"2026-07-21T13:23:39.033307Z","end":"2026-07-21T13:23:39.163942Z","steps":["trace[71430271] 'agreement among raft nodes before linearized reading' (duration: 130.495891ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:23:39.164191Z","caller":"traceutil/trace.go:171","msg":"trace[1182197527] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"155.569458ms","start":"2026-07-21T13:23:39.008599Z","end":"2026-07-21T13:23:39.164168Z","steps":["trace[1182197527] 'process raft request' (duration: 154.431648ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:23:40.564119Z","caller":"traceutil/trace.go:171","msg":"trace[151859857] linearizableReadLoop","detail":"{readStateIndex:1239; appliedIndex:1238; }","duration":"193.118719ms","start":"2026-07-21T13:23:40.370976Z","end":"2026-07-21T13:23:40.564095Z","steps":["trace[151859857] 'read index received' (duration: 192.939974ms)","trace[151859857] 'applied index is now lower than readState.Index' (duration: 178.165µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:23:40.564392Z","caller":"traceutil/trace.go:171","msg":"trace[86854193] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"216.815589ms","start":"2026-07-21T13:23:40.347568Z","end":"2026-07-21T13:23:40.564384Z","steps":["trace[86854193] 'process raft request' (duration: 216.402479ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:40.564667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.677083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-21T13:23:40.564692Z","caller":"traceutil/trace.go:171","msg":"trace[1211096804] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1193; }","duration":"193.732605ms","start":"2026-07-21T13:23:40.370951Z","end":"2026-07-21T13:23:40.564683Z","steps":["trace[1211096804] 'agreement among raft nodes before linearized reading' (duration: 193.634192ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:40.564789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.516164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-21T13:23:40.564807Z","caller":"traceutil/trace.go:171","msg":"trace[1042579235] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1193; }","duration":"192.568065ms","start":"2026-07-21T13:23:40.372234Z","end":"2026-07-21T13:23:40.564802Z","steps":["trace[1042579235] 'agreement among raft nodes before linearized reading' (duration: 192.510774ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:40.564888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.915654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-21T13:23:40.5649Z","caller":"traceutil/trace.go:171","msg":"trace[322313346] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1193; }","duration":"166.954525ms","start":"2026-07-21T13:23:40.397942Z","end":"2026-07-21T13:23:40.564897Z","steps":["trace[322313346] 'agreement among raft nodes before linearized reading' (duration: 166.915434ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:23:40.842289Z","caller":"traceutil/trace.go:171","msg":"trace[1111701175] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"273.123291ms","start":"2026-07-21T13:23:40.569139Z","end":"2026-07-21T13:23:40.842263Z","steps":["trace[1111701175] 'process raft request' (duration: 271.359974ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:23:40.842317Z","caller":"traceutil/trace.go:171","msg":"trace[1070061840] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"273.107191ms","start":"2026-07-21T13:23:40.56919Z","end":"2026-07-21T13:23:40.842297Z","steps":["trace[1070061840] 'process raft request' (duration: 272.897735ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:23:40.842374Z","caller":"traceutil/trace.go:171","msg":"trace[480111611] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"271.752385ms","start":"2026-07-21T13:23:40.570594Z","end":"2026-07-21T13:23:40.842346Z","steps":["trace[480111611] 'process raft request' (duration: 271.55535ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:23:58.84921Z","caller":"traceutil/trace.go:171","msg":"trace[664913902] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"222.922779ms","start":"2026-07-21T13:23:58.626263Z","end":"2026-07-21T13:23:58.849186Z","steps":["trace[664913902] 'process raft request' (duration: 222.883608ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:23:58.849324Z","caller":"traceutil/trace.go:171","msg":"trace[588291189] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"264.184576ms","start":"2026-07-21T13:23:58.585063Z","end":"2026-07-21T13:23:58.849247Z","steps":["trace[588291189] 'process raft request' (duration: 246.288918ms)","trace[588291189] 'compare' (duration: 17.688183ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:23:59.57823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.010266ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-21T13:23:59.57832Z","caller":"traceutil/trace.go:171","msg":"trace[1842618897] linearizableReadLoop","detail":"{readStateIndex:1328; appliedIndex:1327; }","duration":"331.23133ms","start":"2026-07-21T13:23:59.247076Z","end":"2026-07-21T13:23:59.578308Z","steps":["trace[1842618897] 'read index received' (duration: 125.052559ms)","trace[1842618897] 'applied index is now lower than readState.Index' (duration: 206.177981ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:23:59.578382Z","caller":"traceutil/trace.go:171","msg":"trace[1449533336] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"392.101442ms","start":"2026-07-21T13:23:59.186259Z","end":"2026-07-21T13:23:59.578361Z","steps":["trace[1449533336] 'process raft request' (duration: 185.88945ms)","trace[1449533336] 'compare' (duration: 205.905394ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:23:59.578419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.347623ms","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-07-21T13:23:59.578443Z","caller":"traceutil/trace.go:171","msg":"trace[1997527886] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1278; }","duration":"331.393883ms","start":"2026-07-21T13:23:59.247042Z","end":"2026-07-21T13:23:59.578436Z","steps":["trace[1997527886] 'agreement among raft nodes before linearized reading' (duration: 331.298721ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:23:59.578513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:59.186239Z","time spent":"392.186093ms","remote":"127.0.0.1:48230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T13:23:59.578623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:23:59.247031Z","time spent":"331.432055ms","remote":"127.0.0.1:48230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-21T13:23:59.833236Z","caller":"traceutil/trace.go:171","msg":"trace[1778734712] linearizableReadLoop","detail":"{readStateIndex:1329; appliedIndex:1328; }","duration":"174.78686ms","start":"2026-07-21T13:23:59.658422Z","end":"2026-07-21T13:23:59.833209Z","steps":["trace[1778734712] 'read index received' (duration: 152.652541ms)","trace[1778734712] 'applied index is now lower than readState.Index' (duration: 22.133108ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:23:59.833474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.034806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:23:59.833538Z","caller":"traceutil/trace.go:171","msg":"trace[1211969483] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1279; }","duration":"175.129418ms","start":"2026-07-21T13:23:59.658376Z","end":"2026-07-21T13:23:59.833505Z","steps":["trace[1211969483] 'agreement among raft nodes before linearized reading' (duration: 174.998455ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:23:59.833657Z","caller":"traceutil/trace.go:171","msg":"trace[852699647] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"251.640499ms","start":"2026-07-21T13:23:59.581985Z","end":"2026-07-21T13:23:59.833626Z","steps":["trace[852699647] 'process raft request' (duration: 229.09322ms)","trace[852699647] 'compare' (duration: 22.025716ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:24:01.244181Z","caller":"traceutil/trace.go:171","msg":"trace[232225664] linearizableReadLoop","detail":"{readStateIndex:1331; appliedIndex:1330; }","duration":"193.606531ms","start":"2026-07-21T13:24:01.050557Z","end":"2026-07-21T13:24:01.244163Z","steps":["trace[232225664] 'read index received' (duration: 192.073071ms)","trace[232225664] 'applied index is now lower than readState.Index' (duration: 1.53266ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:24:01.244265Z","caller":"traceutil/trace.go:171","msg":"trace[1313292158] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"260.137901ms","start":"2026-07-21T13:24:00.98412Z","end":"2026-07-21T13:24:01.244257Z","steps":["trace[1313292158] 'process raft request' (duration: 258.499768ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:01.244547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.988582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-21T13:24:01.244576Z","caller":"traceutil/trace.go:171","msg":"trace[695136950] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1281; }","duration":"194.065214ms","start":"2026-07-21T13:24:01.050504Z","end":"2026-07-21T13:24:01.244569Z","steps":["trace[695136950] 'agreement among raft nodes before linearized reading' (duration: 193.9226ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:01.244603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.206415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:24:01.244673Z","caller":"traceutil/trace.go:171","msg":"trace[1521226487] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1281; }","duration":"174.342338ms","start":"2026-07-21T13:24:01.070313Z","end":"2026-07-21T13:24:01.244655Z","steps":["trace[1521226487] 'agreement among raft nodes before linearized reading' (duration: 174.205185ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:01.244841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.459622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-21T13:24:01.244939Z","caller":"traceutil/trace.go:171","msg":"trace[1937399593] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1281; }","duration":"114.576876ms","start":"2026-07-21T13:24:01.130328Z","end":"2026-07-21T13:24:01.244905Z","steps":["trace[1937399593] 'agreement among raft nodes before linearized reading' (duration: 114.332309ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:01.245025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.649327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-21T13:24:01.245062Z","caller":"traceutil/trace.go:171","msg":"trace[1324925553] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1281; }","duration":"114.726429ms","start":"2026-07-21T13:24:01.130325Z","end":"2026-07-21T13:24:01.245051Z","steps":["trace[1324925553] 'agreement among raft nodes before linearized reading' (duration: 114.536644ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:01.419373Z","caller":"traceutil/trace.go:171","msg":"trace[1416913778] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"169.733097ms","start":"2026-07-21T13:24:01.249612Z","end":"2026-07-21T13:24:01.419345Z","steps":["trace[1416913778] 'process raft request' (duration: 169.46046ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:01.419495Z","caller":"traceutil/trace.go:171","msg":"trace[2135848727] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"169.679245ms","start":"2026-07-21T13:24:01.249731Z","end":"2026-07-21T13:24:01.41941Z","steps":["trace[2135848727] 'process raft request' (duration: 169.371248ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:01.419514Z","caller":"traceutil/trace.go:171","msg":"trace[1475680529] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"170.487068ms","start":"2026-07-21T13:24:01.249011Z","end":"2026-07-21T13:24:01.419498Z","steps":["trace[1475680529] 'process raft request' (duration: 118.881839ms)","trace[1475680529] 'compare' (duration: 50.782648ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:24:11.835448Z","caller":"traceutil/trace.go:171","msg":"trace[1175644302] linearizableReadLoop","detail":"{readStateIndex:1411; appliedIndex:1410; }","duration":"497.100326ms","start":"2026-07-21T13:24:11.338325Z","end":"2026-07-21T13:24:11.835425Z","steps":["trace[1175644302] 'read index received' (duration: 496.967493ms)","trace[1175644302] 'applied index is now lower than readState.Index' (duration: 131.853µs)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:24:11.835821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.73464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-21T13:24:11.835876Z","caller":"traceutil/trace.go:171","msg":"trace[684855864] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1359; }","duration":"376.862634ms","start":"2026-07-21T13:24:11.459002Z","end":"2026-07-21T13:24:11.835865Z","steps":["trace[684855864] 'agreement among raft nodes before linearized reading' (duration: 376.662068ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:11.835847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.511398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"warn","ts":"2026-07-21T13:24:11.835927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:24:11.458982Z","time spent":"376.927885ms","remote":"127.0.0.1:48230","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-07-21T13:24:11.835962Z","caller":"traceutil/trace.go:171","msg":"trace[114394802] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1359; }","duration":"497.639771ms","start":"2026-07-21T13:24:11.338298Z","end":"2026-07-21T13:24:11.835938Z","steps":["trace[114394802] 'agreement among raft nodes before linearized reading' (duration: 497.364314ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:11.836066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:24:11.338275Z","time spent":"497.775354ms","remote":"127.0.0.1:48230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":550,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-21T13:24:11.836176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.202949ms","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-07-21T13:24:11.83627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.193806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-21T13:24:11.836316Z","caller":"traceutil/trace.go:171","msg":"trace[600279119] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1359; }","duration":"376.259878ms","start":"2026-07-21T13:24:11.460042Z","end":"2026-07-21T13:24:11.836302Z","steps":["trace[600279119] 'agreement among raft nodes before linearized reading' (duration: 376.144705ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:11.836388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:24:11.460032Z","time spent":"376.314329ms","remote":"127.0.0.1:48230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-21T13:24:11.835518Z","caller":"traceutil/trace.go:171","msg":"trace[301663274] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"533.629041ms","start":"2026-07-21T13:24:11.301854Z","end":"2026-07-21T13:24:11.835483Z","steps":["trace[301663274] 'process raft request' (duration: 533.425365ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:11.836297Z","caller":"traceutil/trace.go:171","msg":"trace[1862983794] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1359; }","duration":"375.374494ms","start":"2026-07-21T13:24:11.460903Z","end":"2026-07-21T13:24:11.836278Z","steps":["trace[1862983794] 'agreement among raft nodes before linearized reading' (duration: 375.000505ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:11.836535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:24:11.301839Z","time spent":"534.641578ms","remote":"127.0.0.1:48230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T13:24:11.836615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.912985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-21T13:24:11.836694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:24:11.460894Z","time spent":"375.783615ms","remote":"127.0.0.1:48230","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-07-21T13:24:11.836867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.699034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-07-21T13:24:11.836918Z","caller":"traceutil/trace.go:171","msg":"trace[1995512289] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1359; }","duration":"337.784381ms","start":"2026-07-21T13:24:11.499121Z","end":"2026-07-21T13:24:11.836905Z","steps":["trace[1995512289] 'agreement among raft nodes before linearized reading' (duration: 336.58418ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:24:11.836956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:24:11.499106Z","time spent":"337.840063ms","remote":"127.0.0.1:48230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":498,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-07-21T13:24:11.837466Z","caller":"traceutil/trace.go:171","msg":"trace[419611543] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1359; }","duration":"151.223114ms","start":"2026-07-21T13:24:11.685629Z","end":"2026-07-21T13:24:11.836852Z","steps":["trace[419611543] 'agreement among raft nodes before linearized reading' (duration: 150.920816ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:11.96478Z","caller":"traceutil/trace.go:171","msg":"trace[1788355394] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"124.438134ms","start":"2026-07-21T13:24:11.840311Z","end":"2026-07-21T13:24:11.964749Z","steps":["trace[1788355394] 'process raft request' (duration: 122.939734ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:11.964898Z","caller":"traceutil/trace.go:171","msg":"trace[938581045] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"122.235406ms","start":"2026-07-21T13:24:11.842633Z","end":"2026-07-21T13:24:11.964869Z","steps":["trace[938581045] 'process raft request' (duration: 121.962839ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:11.965014Z","caller":"traceutil/trace.go:171","msg":"trace[941355058] transaction","detail":"{read_only:false; response_revision:1363; number_of_response:1; }","duration":"120.418418ms","start":"2026-07-21T13:24:11.844565Z","end":"2026-07-21T13:24:11.964984Z","steps":["trace[941355058] 'process raft request' (duration: 120.208213ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:11.965081Z","caller":"traceutil/trace.go:171","msg":"trace[879219736] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"122.149094ms","start":"2026-07-21T13:24:11.842731Z","end":"2026-07-21T13:24:11.96488Z","steps":["trace[879219736] 'process raft request' (duration: 121.99461ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:24:11.965205Z","caller":"traceutil/trace.go:171","msg":"trace[1981908716] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"119.955606ms","start":"2026-07-21T13:24:11.84523Z","end":"2026-07-21T13:24:11.965185Z","steps":["trace[1981908716] 'process raft request' (duration: 119.587917ms)"],"step_count":1}