{"level":"warn","ts":"2026-05-09T16:49:11.046656Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-09T16:49:11.046743Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38: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-05-09T16:49:11.046817Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-09T16:49:11.046829Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-05-09T16:49:11.046855Z","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-05-09T16:49:11.0475Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]} {"level":"info","ts":"2026-05-09T16:49:11.047578Z","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.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38: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-05-09T16:49:11.068155Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"20.383672ms"} {"level":"info","ts":"2026-05-09T16:49:11.080774Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"} {"level":"info","ts":"2026-05-09T16:49:11.080867Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"} {"level":"info","ts":"2026-05-09T16:49:11.080907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"} {"level":"info","ts":"2026-05-09T16:49:11.080927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-09T16:49:11.080939Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"} {"level":"info","ts":"2026-05-09T16:49:11.080987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"warn","ts":"2026-05-09T16:49:11.101784Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-09T16:49:11.103254Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-09T16:49:11.104555Z","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-05-09T16:49:11.106629Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-09T16:49:11.106801Z","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-05-09T16:49:11.106954Z","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-05-09T16:49:11.107058Z","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-05-09T16:49:11.106933Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-09T16:49:11.109358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"info","ts":"2026-05-09T16:49:11.1096Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-05-09T16:49:11.113497Z","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-05-09T16:49:11.113775Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-05-09T16:49:11.11383Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-09T16:49:11.113886Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-09T16:49:11.113837Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-05-09T16:49:11.981553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"} {"level":"info","ts":"2026-05-09T16:49:11.981657Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-09T16:49:11.981723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"} {"level":"info","ts":"2026-05-09T16:49:11.981749Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"} {"level":"info","ts":"2026-05-09T16:49:11.981765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-05-09T16:49:11.981785Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"} {"level":"info","ts":"2026-05-09T16:49:11.981802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-05-09T16:49:12.139196Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"} {"level":"info","ts":"2026-05-09T16:49:12.139248Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T16:49:12.139348Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T16:49:12.139327Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T16:49:12.139648Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-09T16:49:12.139683Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-09T16:49:12.145162Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"info","ts":"2026-05-09T16:49:12.146174Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-09T16:49:12.413854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.182268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-09T16:49:12.414002Z","caller":"traceutil/trace.go:171","msg":"trace[753548661] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; }","duration":"127.397624ms","start":"2026-05-09T16:49:12.286593Z","end":"2026-05-09T16:49:12.41399Z","steps":["trace[753548661] 'agreement among raft nodes before linearized reading' (duration: 127.201379ms)"],"step_count":1} 2026/05/09 16:49:12 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-09T16:49:12.413854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.323532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-09T16:49:12.414146Z","caller":"traceutil/trace.go:171","msg":"trace[143308014] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; }","duration":"127.644611ms","start":"2026-05-09T16:49:12.286494Z","end":"2026-05-09T16:49:12.414138Z","steps":["trace[143308014] 'agreement among raft nodes before linearized reading' (duration: 127.341833ms)"],"step_count":1} 2026/05/09 16:49:12 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-05-09T16:49:12.645838Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T16:49:12.645988Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T16:49:12.646038Z","caller":"traceutil/trace.go:171","msg":"trace[545493669] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:3; }","duration":"464.975961ms","start":"2026-05-09T16:49:12.181043Z","end":"2026-05-09T16:49:12.646019Z","steps":["trace[545493669] 'read index received' (duration: 464.775976ms)","trace[545493669] 'applied index is now lower than readState.Index' (duration: 198.475µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:49:12.646112Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-05-09T16:49:12.646232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.161386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.646256Z","caller":"traceutil/trace.go:171","msg":"trace[554535184] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"465.212308ms","start":"2026-05-09T16:49:12.181037Z","end":"2026-05-09T16:49:12.64625Z","steps":["trace[554535184] 'agreement among raft nodes before linearized reading' (duration: 465.094675ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.646277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:12.181021Z","time spent":"465.249288ms","remote":"127.0.0.1:39096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":0,"response size":26,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-05-09T16:49:12.646446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.218087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-09T16:49:12.64648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.316741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.646529Z","caller":"traceutil/trace.go:171","msg":"trace[1371912568] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"184.31976ms","start":"2026-05-09T16:49:12.462195Z","end":"2026-05-09T16:49:12.646515Z","steps":["trace[1371912568] 'agreement among raft nodes before linearized reading' (duration: 184.180576ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:12.646549Z","caller":"traceutil/trace.go:171","msg":"trace[659683324] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"465.450454ms","start":"2026-05-09T16:49:12.181081Z","end":"2026-05-09T16:49:12.646531Z","steps":["trace[659683324] 'agreement among raft nodes before linearized reading' (duration: 465.292679ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.646604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:12.181075Z","time spent":"465.510976ms","remote":"127.0.0.1:39096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":121,"response count":0,"response size":26,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 "} {"level":"warn","ts":"2026-05-09T16:49:12.646648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.521706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-09T16:49:12.646608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.044086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-09T16:49:12.646696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.66636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.646713Z","caller":"traceutil/trace.go:171","msg":"trace[1064202765] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"196.692791ms","start":"2026-05-09T16:49:12.450016Z","end":"2026-05-09T16:49:12.646709Z","steps":["trace[1064202765] 'agreement among raft nodes before linearized reading' (duration: 196.663071ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:12.646717Z","caller":"traceutil/trace.go:171","msg":"trace[1404336622] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"371.190381ms","start":"2026-05-09T16:49:12.2755Z","end":"2026-05-09T16:49:12.646691Z","steps":["trace[1404336622] 'agreement among raft nodes before linearized reading' (duration: 371.007096ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.646719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.393844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-09T16:49:12.646752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.236232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-09T16:49:12.646767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:12.275486Z","time spent":"371.270513ms","remote":"127.0.0.1:39160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-05-09T16:49:12.646758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.053885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.646796Z","caller":"traceutil/trace.go:171","msg":"trace[1742230595] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"336.496796ms","start":"2026-05-09T16:49:12.310278Z","end":"2026-05-09T16:49:12.646775Z","steps":["trace[1742230595] 'agreement among raft nodes before linearized reading' (duration: 336.357562ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:12.646812Z","caller":"traceutil/trace.go:171","msg":"trace[290973193] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"371.305554ms","start":"2026-05-09T16:49:12.275481Z","end":"2026-05-09T16:49:12.646786Z","steps":["trace[290973193] 'agreement among raft nodes before linearized reading' (duration: 371.235902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.646838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.541637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.646826Z","caller":"traceutil/trace.go:171","msg":"trace[1700905034] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"348.171038ms","start":"2026-05-09T16:49:12.298638Z","end":"2026-05-09T16:49:12.646809Z","steps":["trace[1700905034] 'agreement among raft nodes before linearized reading' (duration: 348.044925ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:12.646856Z","caller":"traceutil/trace.go:171","msg":"trace[1027584729] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"232.598348ms","start":"2026-05-09T16:49:12.414253Z","end":"2026-05-09T16:49:12.646851Z","steps":["trace[1027584729] 'agreement among raft nodes before linearized reading' (duration: 232.569688ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.646848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:12.310264Z","time spent":"336.571099ms","remote":"127.0.0.1:39194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-05-09T16:49:12.648048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.05509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.648183Z","caller":"traceutil/trace.go:171","msg":"trace[531719503] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"326.193353ms","start":"2026-05-09T16:49:12.321946Z","end":"2026-05-09T16:49:12.64814Z","steps":["trace[531719503] 'agreement among raft nodes before linearized reading' (duration: 324.916028ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.648206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.509425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-09T16:49:12.648241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:12.321934Z","time spent":"326.294676ms","remote":"127.0.0.1:39206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":0,"response size":26,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" limit:10000 "} {"level":"info","ts":"2026-05-09T16:49:12.648303Z","caller":"traceutil/trace.go:171","msg":"trace[1903564774] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"349.643658ms","start":"2026-05-09T16:49:12.298615Z","end":"2026-05-09T16:49:12.648259Z","steps":["trace[1903564774] 'agreement among raft nodes before linearized reading' (duration: 349.245127ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.648355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:12.29859Z","time spent":"349.752931ms","remote":"127.0.0.1:39178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":26,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-05-09T16:49:12.649077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.238751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.64916Z","caller":"traceutil/trace.go:171","msg":"trace[750616117] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"235.329354ms","start":"2026-05-09T16:49:12.413801Z","end":"2026-05-09T16:49:12.64913Z","steps":["trace[750616117] 'agreement among raft nodes before linearized reading' (duration: 234.638305ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.64931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.005865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.649393Z","caller":"traceutil/trace.go:171","msg":"trace[1510430833] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"315.100949ms","start":"2026-05-09T16:49:12.334268Z","end":"2026-05-09T16:49:12.649369Z","steps":["trace[1510430833] 'agreement among raft nodes before linearized reading' (duration: 314.546353ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.649463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:12.33426Z","time spent":"315.190651ms","remote":"127.0.0.1:39208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":26,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" limit:10000 "} {"level":"info","ts":"2026-05-09T16:49:12.646669Z","caller":"traceutil/trace.go:171","msg":"trace[244252526] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"184.571697ms","start":"2026-05-09T16:49:12.462091Z","end":"2026-05-09T16:49:12.646663Z","steps":["trace[244252526] 'agreement among raft nodes before linearized reading' (duration: 184.541946ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.650388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.875747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.650435Z","caller":"traceutil/trace.go:171","msg":"trace[414331117] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"252.953688ms","start":"2026-05-09T16:49:12.397466Z","end":"2026-05-09T16:49:12.650419Z","steps":["trace[414331117] 'agreement among raft nodes before linearized reading' (duration: 252.64125ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.651971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.875395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.652037Z","caller":"traceutil/trace.go:171","msg":"trace[1276452303] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"393.968227ms","start":"2026-05-09T16:49:12.258043Z","end":"2026-05-09T16:49:12.652011Z","steps":["trace[1276452303] 'agreement among raft nodes before linearized reading' (duration: 388.832316ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.652081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:12.258014Z","time spent":"394.05703ms","remote":"127.0.0.1:39158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":26,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-05-09T16:49:12.652137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.123371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-09T16:49:12.652279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.948692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.652338Z","caller":"traceutil/trace.go:171","msg":"trace[1745776788] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"317.798052ms","start":"2026-05-09T16:49:12.334513Z","end":"2026-05-09T16:49:12.652311Z","steps":["trace[1745776788] 'agreement among raft nodes before linearized reading' (duration: 311.89327ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.65237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:12.334509Z","time spent":"317.850054ms","remote":"127.0.0.1:39208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":26,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"info","ts":"2026-05-09T16:49:12.65232Z","caller":"traceutil/trace.go:171","msg":"trace[937343585] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"330.331466ms","start":"2026-05-09T16:49:12.321911Z","end":"2026-05-09T16:49:12.652242Z","steps":["trace[937343585] 'agreement among raft nodes before linearized reading' (duration: 325.939556ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.65248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:12.321889Z","time spent":"330.565843ms","remote":"127.0.0.1:39206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":26,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-05-09T16:49:12.646856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:12.275469Z","time spent":"371.375696ms","remote":"127.0.0.1:39160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 "} {"level":"warn","ts":"2026-05-09T16:49:12.64681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.805804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-09T16:49:12.646619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.26364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.653229Z","caller":"traceutil/trace.go:171","msg":"trace[1761584130] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"266.8623ms","start":"2026-05-09T16:49:12.386328Z","end":"2026-05-09T16:49:12.653191Z","steps":["trace[1761584130] 'agreement among raft nodes before linearized reading' (duration: 260.268819ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.653292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.438358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.653349Z","caller":"traceutil/trace.go:171","msg":"trace[361111756] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1; }","duration":"114.53594ms","start":"2026-05-09T16:49:12.538798Z","end":"2026-05-09T16:49:12.653334Z","steps":["trace[361111756] 'agreement among raft nodes before linearized reading' (duration: 113.874792ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.653416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.958704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.653482Z","caller":"traceutil/trace.go:171","msg":"trace[663899463] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1; }","duration":"102.091358ms","start":"2026-05-09T16:49:12.551375Z","end":"2026-05-09T16:49:12.653467Z","steps":["trace[663899463] 'agreement among raft nodes before linearized reading' (duration: 101.289926ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.653673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.341826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-09T16:49:12.653807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.463514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-09T16:49:12.653842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.506211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-09T16:49:12.653897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.340308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.653922Z","caller":"traceutil/trace.go:171","msg":"trace[969606197] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"278.586764ms","start":"2026-05-09T16:49:12.375299Z","end":"2026-05-09T16:49:12.653885Z","steps":["trace[969606197] 'agreement among raft nodes before linearized reading' (duration: 277.456682ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:12.653937Z","caller":"traceutil/trace.go:171","msg":"trace[2088339626] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1; }","duration":"165.403ms","start":"2026-05-09T16:49:12.488526Z","end":"2026-05-09T16:49:12.653929Z","steps":["trace[2088339626] 'agreement among raft nodes before linearized reading' (duration: 164.209697ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.653994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.352665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.654053Z","caller":"traceutil/trace.go:171","msg":"trace[667285318] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1; }","duration":"102.48846ms","start":"2026-05-09T16:49:12.551542Z","end":"2026-05-09T16:49:12.65403Z","steps":["trace[667285318] 'agreement among raft nodes before linearized reading' (duration: 101.120092ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.654123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.592565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.654169Z","caller":"traceutil/trace.go:171","msg":"trace[166103200] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1; }","duration":"165.652597ms","start":"2026-05-09T16:49:12.488506Z","end":"2026-05-09T16:49:12.654159Z","steps":["trace[166103200] 'agreement among raft nodes before linearized reading' (duration: 164.232638ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.654317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.818549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-09T16:49:12.654351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.282073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.654365Z","caller":"traceutil/trace.go:171","msg":"trace[1199348152] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1; }","duration":"178.87807ms","start":"2026-05-09T16:49:12.475471Z","end":"2026-05-09T16:49:12.654349Z","steps":["trace[1199348152] 'agreement among raft nodes before linearized reading' (duration: 177.274916ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:12.654398Z","caller":"traceutil/trace.go:171","msg":"trace[1611745728] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"303.321564ms","start":"2026-05-09T16:49:12.351055Z","end":"2026-05-09T16:49:12.654376Z","steps":["trace[1611745728] 'agreement among raft nodes before linearized reading' (duration: 301.7124ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.654442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:12.351026Z","time spent":"303.405377ms","remote":"127.0.0.1:39212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":26,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-05-09T16:49:12.654346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.266881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.653856Z","caller":"traceutil/trace.go:171","msg":"trace[374865791] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1; }","duration":"152.530266ms","start":"2026-05-09T16:49:12.501303Z","end":"2026-05-09T16:49:12.653833Z","steps":["trace[374865791] 'agreement among raft nodes before linearized reading' (duration: 151.429756ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.655411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.838567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.655475Z","caller":"traceutil/trace.go:171","msg":"trace[172095549] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1; }","duration":"139.984831ms","start":"2026-05-09T16:49:12.515479Z","end":"2026-05-09T16:49:12.655463Z","steps":["trace[172095549] 'agreement among raft nodes before linearized reading' (duration: 137.243976ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.655641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.394906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.655642Z","caller":"traceutil/trace.go:171","msg":"trace[1971526543] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"204.792624ms","start":"2026-05-09T16:49:12.44997Z","end":"2026-05-09T16:49:12.654763Z","steps":["trace[1971526543] 'agreement among raft nodes before linearized reading' (duration: 196.818375ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.655689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.25572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.655793Z","caller":"traceutil/trace.go:171","msg":"trace[1490816030] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"292.376223ms","start":"2026-05-09T16:49:12.363371Z","end":"2026-05-09T16:49:12.655748Z","steps":["trace[1490816030] 'agreement among raft nodes before linearized reading' (duration: 289.386941ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.655978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.489041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.655714Z","caller":"traceutil/trace.go:171","msg":"trace[1282379706] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"345.434732ms","start":"2026-05-09T16:49:12.310252Z","end":"2026-05-09T16:49:12.655687Z","steps":["trace[1282379706] 'agreement among raft nodes before linearized reading' (duration: 343.380386ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.656069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:12.310245Z","time spent":"345.786542ms","remote":"127.0.0.1:39194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":0,"response size":26,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 "} {"level":"warn","ts":"2026-05-09T16:49:12.656119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.476875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.65614Z","caller":"traceutil/trace.go:171","msg":"trace[1222198577] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1; }","duration":"180.542107ms","start":"2026-05-09T16:49:12.475592Z","end":"2026-05-09T16:49:12.656134Z","steps":["trace[1222198577] 'agreement among raft nodes before linearized reading' (duration: 177.150513ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.656235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.633649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-09T16:49:12.656251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.596717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.656313Z","caller":"traceutil/trace.go:171","msg":"trace[1219619776] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1; }","duration":"140.68675ms","start":"2026-05-09T16:49:12.5156Z","end":"2026-05-09T16:49:12.656287Z","steps":["trace[1219619776] 'agreement among raft nodes before linearized reading' (duration: 137.119642ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:12.656335Z","caller":"traceutil/trace.go:171","msg":"trace[510478647] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1; }","duration":"128.719941ms","start":"2026-05-09T16:49:12.527573Z","end":"2026-05-09T16:49:12.656293Z","steps":["trace[510478647] 'agreement among raft nodes before linearized reading' (duration: 125.131412ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.6564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.704633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.656429Z","caller":"traceutil/trace.go:171","msg":"trace[1976059802] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"436.781355ms","start":"2026-05-09T16:49:12.21964Z","end":"2026-05-09T16:49:12.656421Z","steps":["trace[1976059802] 'agreement among raft nodes before linearized reading' (duration: 433.167756ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.656435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.395401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-09T16:49:12.656448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.102633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.656486Z","caller":"traceutil/trace.go:171","msg":"trace[1436436928] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"305.449373ms","start":"2026-05-09T16:49:12.351026Z","end":"2026-05-09T16:49:12.656476Z","steps":["trace[1436436928] 'agreement among raft nodes before linearized reading' (duration: 301.744081ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:12.65651Z","caller":"traceutil/trace.go:171","msg":"trace[1415128036] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"281.181135ms","start":"2026-05-09T16:49:12.375298Z","end":"2026-05-09T16:49:12.656479Z","steps":["trace[1415128036] 'agreement among raft nodes before linearized reading' (duration: 277.452962ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.656557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.476147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-09T16:49:12.646874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:12.29863Z","time spent":"348.23316ms","remote":"127.0.0.1:39178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":26,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" limit:10000 "} {"level":"info","ts":"2026-05-09T16:49:12.656597Z","caller":"traceutil/trace.go:171","msg":"trace[1599958003] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"412.528948ms","start":"2026-05-09T16:49:12.244055Z","end":"2026-05-09T16:49:12.656584Z","steps":["trace[1599958003] 'agreement among raft nodes before linearized reading' (duration: 408.733683ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.656628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.681768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.653732Z","caller":"traceutil/trace.go:171","msg":"trace[425462498] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"290.403289ms","start":"2026-05-09T16:49:12.363304Z","end":"2026-05-09T16:49:12.653708Z","steps":["trace[425462498] 'agreement among raft nodes before linearized reading' (duration: 289.458463ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:12.656665Z","caller":"traceutil/trace.go:171","msg":"trace[1221500082] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"422.743359ms","start":"2026-05-09T16:49:12.233905Z","end":"2026-05-09T16:49:12.656649Z","steps":["trace[1221500082] 'agreement among raft nodes before linearized reading' (duration: 418.908703ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.656687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:12.233898Z","time spent":"422.784551ms","remote":"127.0.0.1:39128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 "} {"level":"warn","ts":"2026-05-09T16:49:12.656719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.706238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.656752Z","caller":"traceutil/trace.go:171","msg":"trace[1666402129] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"398.770279ms","start":"2026-05-09T16:49:12.257968Z","end":"2026-05-09T16:49:12.656738Z","steps":["trace[1666402129] 'agreement among raft nodes before linearized reading' (duration: 394.81409ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.656773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:12.257946Z","time spent":"398.822001ms","remote":"127.0.0.1:39158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":26,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 "} {"level":"warn","ts":"2026-05-09T16:49:12.656821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.715553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.656848Z","caller":"traceutil/trace.go:171","msg":"trace[778353398] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"412.760105ms","start":"2026-05-09T16:49:12.244078Z","end":"2026-05-09T16:49:12.656838Z","steps":["trace[778353398] 'agreement among raft nodes before linearized reading' (duration: 408.707673ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.656866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:12.244067Z","time spent":"412.792985ms","remote":"127.0.0.1:39144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":26,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 "} {"level":"warn","ts":"2026-05-09T16:49:12.65702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.210258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.657049Z","caller":"traceutil/trace.go:171","msg":"trace[2123182160] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"270.739407ms","start":"2026-05-09T16:49:12.386299Z","end":"2026-05-09T16:49:12.657039Z","steps":["trace[2123182160] 'agreement among raft nodes before linearized reading' (duration: 266.378017ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:12.656008Z","caller":"traceutil/trace.go:171","msg":"trace[605454691] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"258.550833ms","start":"2026-05-09T16:49:12.39745Z","end":"2026-05-09T16:49:12.656Z","steps":["trace[605454691] 'agreement among raft nodes before linearized reading' (duration: 255.219181ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:12.657198Z","caller":"traceutil/trace.go:171","msg":"trace[2026691401] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"423.155101ms","start":"2026-05-09T16:49:12.234033Z","end":"2026-05-09T16:49:12.657188Z","steps":["trace[2026691401] 'agreement among raft nodes before linearized reading' (duration: 418.744759ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.656632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:12.244045Z","time spent":"412.574129ms","remote":"127.0.0.1:39144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":26,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-05-09T16:49:12.657219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:12.234008Z","time spent":"423.203601ms","remote":"127.0.0.1:39128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-05-09T16:49:12.656086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.706346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.657291Z","caller":"traceutil/trace.go:171","msg":"trace[1279790047] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1; }","duration":"155.921839ms","start":"2026-05-09T16:49:12.501357Z","end":"2026-05-09T16:49:12.657279Z","steps":["trace[1279790047] 'agreement among raft nodes before linearized reading' (duration: 151.368454ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.656462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:12.219611Z","time spent":"436.841646ms","remote":"127.0.0.1:39116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":0,"response size":26,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-05-09T16:49:12.656524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:12.350996Z","time spent":"305.514474ms","remote":"127.0.0.1:39212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":0,"response size":26,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" limit:10000 "} {"level":"warn","ts":"2026-05-09T16:49:12.655805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.256528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.657949Z","caller":"traceutil/trace.go:171","msg":"trace[678685576] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1; }","duration":"130.219582ms","start":"2026-05-09T16:49:12.527491Z","end":"2026-05-09T16:49:12.65771Z","steps":["trace[678685576] 'agreement among raft nodes before linearized reading' (duration: 125.225684ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:12.657022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.112749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:49:12.659008Z","caller":"traceutil/trace.go:171","msg":"trace[532365205] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1; }","duration":"120.093673ms","start":"2026-05-09T16:49:12.538902Z","end":"2026-05-09T16:49:12.658996Z","steps":["trace[532365205] 'agreement among raft nodes before linearized reading' (duration: 113.767749ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:17.325565Z","caller":"traceutil/trace.go:171","msg":"trace[875534091] transaction","detail":"{read_only:false; response_revision:253; number_of_response:1; }","duration":"203.880214ms","start":"2026-05-09T16:49:17.12166Z","end":"2026-05-09T16:49:17.32554Z","steps":["trace[875534091] 'process raft request' (duration: 203.836353ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:17.326014Z","caller":"traceutil/trace.go:171","msg":"trace[340397462] transaction","detail":"{read_only:false; response_revision:252; number_of_response:1; }","duration":"250.590271ms","start":"2026-05-09T16:49:17.075356Z","end":"2026-05-09T16:49:17.325946Z","steps":["trace[340397462] 'process raft request' (duration: 171.298159ms)","trace[340397462] 'compare' (duration: 78.672275ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:49:18.191869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.858612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-09T16:49:18.191946Z","caller":"traceutil/trace.go:171","msg":"trace[401236648] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:272; }","duration":"120.946634ms","start":"2026-05-09T16:49:18.07098Z","end":"2026-05-09T16:49:18.191926Z","steps":["trace[401236648] 'range keys from in-memory index tree' (duration: 120.750949ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:21.611967Z","caller":"traceutil/trace.go:171","msg":"trace[701918470] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"131.938777ms","start":"2026-05-09T16:49:21.479985Z","end":"2026-05-09T16:49:21.611924Z","steps":["trace[701918470] 'process raft request' (duration: 131.580398ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:22.677214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.428985ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-09T16:49:22.677601Z","caller":"traceutil/trace.go:171","msg":"trace[1968154037] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"372.525903ms","start":"2026-05-09T16:49:22.305044Z","end":"2026-05-09T16:49:22.67757Z","steps":["trace[1968154037] 'process raft request' (duration: 116.861285ms)","trace[1968154037] 'compare' (duration: 254.210039ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:49:22.677702Z","caller":"traceutil/trace.go:171","msg":"trace[1671639317] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"371.67133ms","start":"2026-05-09T16:49:22.306016Z","end":"2026-05-09T16:49:22.677688Z","steps":["trace[1671639317] 'process raft request' (duration: 371.540637ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:22.677723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:22.305027Z","time spent":"372.646056ms","remote":"127.0.0.1:39116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:49:22.678502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:22.306009Z","time spent":"371.736352ms","remote":"127.0.0.1:39234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4001,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T16:49:24.485643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.612074923s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T16:49:24.485795Z","caller":"traceutil/trace.go:171","msg":"trace[1505152420] linearizableReadLoop","detail":"{readStateIndex:353; appliedIndex:352; }","duration":"1.858604136s","start":"2026-05-09T16:49:22.627167Z","end":"2026-05-09T16:49:24.485771Z","steps":["trace[1505152420] 'read index received' (duration: 246.230065ms)","trace[1505152420] 'applied index is now lower than readState.Index' (duration: 1.612372601s)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:49:24.486155Z","caller":"traceutil/trace.go:171","msg":"trace[1289861953] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"2.145839742s","start":"2026-05-09T16:49:22.340293Z","end":"2026-05-09T16:49:24.486133Z","steps":["trace[1289861953] 'process raft request' (duration: 533.145032ms)","trace[1289861953] 'compare' (duration: 1.611913369s)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:49:24.486259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:22.340264Z","time spent":"2.145947544s","remote":"127.0.0.1:39508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3804,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T16:49:24.486711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.859547191s","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-05-09T16:49:24.486759Z","caller":"traceutil/trace.go:171","msg":"trace[1079329942] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:341; }","duration":"1.859645404s","start":"2026-05-09T16:49:22.627097Z","end":"2026-05-09T16:49:24.486742Z","steps":["trace[1079329942] 'agreement among raft nodes before linearized reading' (duration: 1.859554622s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:24.486804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:22.627069Z","time spent":"1.859724396s","remote":"127.0.0.1:39234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4344,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"info","ts":"2026-05-09T16:49:24.571402Z","caller":"traceutil/trace.go:171","msg":"trace[1177968010] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"829.942575ms","start":"2026-05-09T16:49:23.741412Z","end":"2026-05-09T16:49:24.571355Z","steps":["trace[1177968010] 'process raft request' (duration: 829.718969ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:24.571451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"867.14667ms","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-05-09T16:49:24.571542Z","caller":"traceutil/trace.go:171","msg":"trace[1234206367] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:342; }","duration":"867.276504ms","start":"2026-05-09T16:49:23.704243Z","end":"2026-05-09T16:49:24.57152Z","steps":["trace[1234206367] 'agreement among raft nodes before linearized reading' (duration: 867.055508ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:24.571507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.679062ms","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-05-09T16:49:24.571586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:23.70423Z","time spent":"867.347585ms","remote":"127.0.0.1:39288","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-05-09T16:49:24.571625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.624577418s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-09T16:49:24.571525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"947.214504ms","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-05-09T16:49:24.571654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:23.741379Z","time spent":"830.15004ms","remote":"127.0.0.1:39288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T16:49:24.571674Z","caller":"traceutil/trace.go:171","msg":"trace[1310031204] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:342; }","duration":"1.624669641s","start":"2026-05-09T16:49:22.946988Z","end":"2026-05-09T16:49:24.571658Z","steps":["trace[1310031204] 'agreement among raft nodes before linearized reading' (duration: 1.624600469s)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:24.571674Z","caller":"traceutil/trace.go:171","msg":"trace[1631764535] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:342; }","duration":"947.367778ms","start":"2026-05-09T16:49:23.624294Z","end":"2026-05-09T16:49:24.571662Z","steps":["trace[1631764535] 'agreement among raft nodes before linearized reading' (duration: 947.164832ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:24.571729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:23.62423Z","time spent":"947.485541ms","remote":"127.0.0.1:39288","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":"warn","ts":"2026-05-09T16:49:24.571729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:22.946962Z","time spent":"1.624753473s","remote":"127.0.0.1:39288","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":"info","ts":"2026-05-09T16:49:24.571623Z","caller":"traceutil/trace.go:171","msg":"trace[536210121] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:342; }","duration":"519.868817ms","start":"2026-05-09T16:49:24.051724Z","end":"2026-05-09T16:49:24.571593Z","steps":["trace[536210121] 'agreement among raft nodes before linearized reading' (duration: 519.568929ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:24.571945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:24.051682Z","time spent":"520.250547ms","remote":"127.0.0.1:39288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-09T16:49:25.072315Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020295590292448,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T16:49:25.573418Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020295590292448,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T16:49:26.074425Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020295590292448,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T16:49:26.244547Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.673132314s","expected-duration":"1s"} {"level":"info","ts":"2026-05-09T16:49:26.321519Z","caller":"traceutil/trace.go:171","msg":"trace[364647889] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"1.825500916s","start":"2026-05-09T16:49:24.495977Z","end":"2026-05-09T16:49:26.321478Z","steps":["trace[364647889] 'process raft request' (duration: 1.7489723s)","trace[364647889] 'compare' (duration: 76.229779ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:49:26.321794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:24.495909Z","time spent":"1.825684762s","remote":"127.0.0.1:39234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4307,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T16:49:26.321808Z","caller":"traceutil/trace.go:171","msg":"trace[1833571105] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"1.825247439s","start":"2026-05-09T16:49:24.496529Z","end":"2026-05-09T16:49:26.321776Z","steps":["trace[1833571105] 'process raft request' (duration: 1.825030384s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:26.322121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:24.496499Z","time spent":"1.825517367s","remote":"127.0.0.1:39476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4041,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T16:49:26.329377Z","caller":"traceutil/trace.go:171","msg":"trace[91481503] linearizableReadLoop","detail":"{readStateIndex:360; appliedIndex:354; }","duration":"1.758086585s","start":"2026-05-09T16:49:24.571272Z","end":"2026-05-09T16:49:26.329359Z","steps":["trace[91481503] 'read index received' (duration: 1.673574097s)","trace[91481503] 'applied index is now lower than readState.Index' (duration: 84.511078ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:49:26.329545Z","caller":"traceutil/trace.go:171","msg":"trace[406377166] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"1.752725432s","start":"2026-05-09T16:49:24.576779Z","end":"2026-05-09T16:49:26.329504Z","steps":["trace[406377166] 'process raft request' (duration: 1.752376583s)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:26.329406Z","caller":"traceutil/trace.go:171","msg":"trace[123746117] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"1.752241619s","start":"2026-05-09T16:49:24.577139Z","end":"2026-05-09T16:49:26.329381Z","steps":["trace[123746117] 'process raft request' (duration: 1.752103985s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:26.329713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.836724136s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-7c96b6546b\" ","response":"range_response_count:1 size:3819"} {"level":"info","ts":"2026-05-09T16:49:26.329764Z","caller":"traceutil/trace.go:171","msg":"trace[1083637653] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-7c96b6546b; range_end:; response_count:1; response_revision:348; }","duration":"1.836834009s","start":"2026-05-09T16:49:24.492918Z","end":"2026-05-09T16:49:26.329752Z","steps":["trace[1083637653] 'agreement among raft nodes before linearized reading' (duration: 1.836643614s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:26.329805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:24.4929Z","time spent":"1.83689598s","remote":"127.0.0.1:39508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":3841,"request content":"key:\"/registry/replicasets/kube-system/coredns-7c96b6546b\" "} {"level":"warn","ts":"2026-05-09T16:49:26.329822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:24.576752Z","time spent":"1.752887946s","remote":"127.0.0.1:39288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T16:49:26.329838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:24.577122Z","time spent":"1.752606569s","remote":"127.0.0.1:39288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T16:49:26.329428Z","caller":"traceutil/trace.go:171","msg":"trace[793158444] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"1.751854589s","start":"2026-05-09T16:49:24.577544Z","end":"2026-05-09T16:49:26.329398Z","steps":["trace[793158444] 'process raft request' (duration: 1.751760496s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:26.330052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:24.577533Z","time spent":"1.752490116s","remote":"127.0.0.1:39288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T16:49:26.329523Z","caller":"traceutil/trace.go:171","msg":"trace[367736194] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"1.75264952s","start":"2026-05-09T16:49:24.576695Z","end":"2026-05-09T16:49:26.329345Z","steps":["trace[367736194] 'process raft request' (duration: 1.752291431s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:26.330243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.294138234s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T16:49:26.330276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.199322546s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.38\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-09T16:49:26.330326Z","caller":"traceutil/trace.go:171","msg":"trace[470970414] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:348; }","duration":"1.294224446s","start":"2026-05-09T16:49:25.036093Z","end":"2026-05-09T16:49:26.330317Z","steps":["trace[470970414] 'agreement among raft nodes before linearized reading' (duration: 1.294127283s)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:26.330336Z","caller":"traceutil/trace.go:171","msg":"trace[1694562213] range","detail":"{range_begin:/registry/masterleases/199.204.45.38; range_end:; response_count:1; response_revision:348; }","duration":"1.199431029s","start":"2026-05-09T16:49:25.130893Z","end":"2026-05-09T16:49:26.330324Z","steps":["trace[1694562213] 'agreement among raft nodes before linearized reading' (duration: 1.199337877s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:26.330365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:25.130863Z","time spent":"1.19949377s","remote":"127.0.0.1:39072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.204.45.38\" "} {"level":"warn","ts":"2026-05-09T16:49:26.330689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:24.57666Z","time spent":"1.753517623s","remote":"127.0.0.1:39288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T16:49:28.028915Z","caller":"traceutil/trace.go:171","msg":"trace[413793447] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"105.209113ms","start":"2026-05-09T16:49:27.923646Z","end":"2026-05-09T16:49:28.028855Z","steps":["trace[413793447] 'process raft request' (duration: 32.36844ms)","trace[413793447] 'compare' (duration: 72.570576ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:49:32.489183Z","caller":"traceutil/trace.go:171","msg":"trace[1118693793] linearizableReadLoop","detail":"{readStateIndex:387; appliedIndex:386; }","duration":"123.587294ms","start":"2026-05-09T16:49:32.365568Z","end":"2026-05-09T16:49:32.489156Z","steps":["trace[1118693793] 'read index received' (duration: 123.400009ms)","trace[1118693793] 'applied index is now lower than readState.Index' (duration: 185.645µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:49:32.489247Z","caller":"traceutil/trace.go:171","msg":"trace[1053156016] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"124.739084ms","start":"2026-05-09T16:49:32.364471Z","end":"2026-05-09T16:49:32.48921Z","steps":["trace[1053156016] 'process raft request' (duration: 124.488318ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:32.489327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.726748ms","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-05-09T16:49:32.489363Z","caller":"traceutil/trace.go:171","msg":"trace[1712947997] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:372; }","duration":"123.800889ms","start":"2026-05-09T16:49:32.365551Z","end":"2026-05-09T16:49:32.489352Z","steps":["trace[1712947997] 'agreement among raft nodes before linearized reading' (duration: 123.707647ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:32.547324Z","caller":"traceutil/trace.go:171","msg":"trace[756781448] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"179.858016ms","start":"2026-05-09T16:49:32.367445Z","end":"2026-05-09T16:49:32.547303Z","steps":["trace[756781448] 'process raft request' (duration: 179.61698ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:32.548736Z","caller":"traceutil/trace.go:171","msg":"trace[1201525623] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"180.649377ms","start":"2026-05-09T16:49:32.366485Z","end":"2026-05-09T16:49:32.547135Z","steps":["trace[1201525623] 'process raft request' (duration: 180.197415ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:32.550218Z","caller":"traceutil/trace.go:171","msg":"trace[1402503742] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"182.690191ms","start":"2026-05-09T16:49:32.367478Z","end":"2026-05-09T16:49:32.550168Z","steps":["trace[1402503742] 'process raft request' (duration: 179.707562ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:32.619371Z","caller":"traceutil/trace.go:171","msg":"trace[798886989] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"124.080886ms","start":"2026-05-09T16:49:32.49526Z","end":"2026-05-09T16:49:32.619341Z","steps":["trace[798886989] 'process raft request' (duration: 76.742051ms)","trace[798886989] 'compare' (duration: 47.202372ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:49:32.81714Z","caller":"traceutil/trace.go:171","msg":"trace[2010146962] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"101.913564ms","start":"2026-05-09T16:49:32.715184Z","end":"2026-05-09T16:49:32.817098Z","steps":["trace[2010146962] 'process raft request' (duration: 101.635506ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:32.817283Z","caller":"traceutil/trace.go:171","msg":"trace[175088574] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"100.559717ms","start":"2026-05-09T16:49:32.716677Z","end":"2026-05-09T16:49:32.817237Z","steps":["trace[175088574] 'process raft request' (duration: 100.333341ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:32.817439Z","caller":"traceutil/trace.go:171","msg":"trace[1031865424] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"100.454765ms","start":"2026-05-09T16:49:32.716913Z","end":"2026-05-09T16:49:32.817367Z","steps":["trace[1031865424] 'process raft request' (duration: 100.25784ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:32.956973Z","caller":"traceutil/trace.go:171","msg":"trace[2124204872] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"132.20715ms","start":"2026-05-09T16:49:32.824727Z","end":"2026-05-09T16:49:32.956935Z","steps":["trace[2124204872] 'process raft request' (duration: 54.672759ms)","trace[2124204872] 'compare' (duration: 77.273804ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:49:32.957257Z","caller":"traceutil/trace.go:171","msg":"trace[1646971213] linearizableReadLoop","detail":"{readStateIndex:402; appliedIndex:400; }","duration":"130.625429ms","start":"2026-05-09T16:49:32.826598Z","end":"2026-05-09T16:49:32.957223Z","steps":["trace[1646971213] 'read index received' (duration: 10.464135ms)","trace[1646971213] 'applied index is now lower than readState.Index' (duration: 120.159794ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:49:32.957408Z","caller":"traceutil/trace.go:171","msg":"trace[666393867] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"128.38256ms","start":"2026-05-09T16:49:32.828995Z","end":"2026-05-09T16:49:32.957377Z","steps":["trace[666393867] 'process raft request' (duration: 127.841846ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:32.957429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.812284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-05-09T16:49:32.957565Z","caller":"traceutil/trace.go:171","msg":"trace[1071807860] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:388; }","duration":"130.983288ms","start":"2026-05-09T16:49:32.826566Z","end":"2026-05-09T16:49:32.957549Z","steps":["trace[1071807860] 'agreement among raft nodes before linearized reading' (duration: 130.768453ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:33.155415Z","caller":"traceutil/trace.go:171","msg":"trace[1632346247] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"169.522287ms","start":"2026-05-09T16:49:32.985862Z","end":"2026-05-09T16:49:33.155384Z","steps":["trace[1632346247] 'process raft request' (duration: 169.423854ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:33.15544Z","caller":"traceutil/trace.go:171","msg":"trace[807940416] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"172.114125ms","start":"2026-05-09T16:49:32.983288Z","end":"2026-05-09T16:49:33.155402Z","steps":["trace[807940416] 'process raft request' (duration: 80.519658ms)","trace[807940416] 'compare' (duration: 91.248508ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:49:33.189962Z","caller":"traceutil/trace.go:171","msg":"trace[1903727186] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"151.206175ms","start":"2026-05-09T16:49:33.03873Z","end":"2026-05-09T16:49:33.189936Z","steps":["trace[1903727186] 'process raft request' (duration: 150.99858ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:33.354326Z","caller":"traceutil/trace.go:171","msg":"trace[817505160] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"111.07145ms","start":"2026-05-09T16:49:33.243221Z","end":"2026-05-09T16:49:33.354293Z","steps":["trace[817505160] 'process raft request' (duration: 110.984197ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:33.354362Z","caller":"traceutil/trace.go:171","msg":"trace[1728184740] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"158.676441ms","start":"2026-05-09T16:49:33.195646Z","end":"2026-05-09T16:49:33.354322Z","steps":["trace[1728184740] 'process raft request' (duration: 84.005197ms)","trace[1728184740] 'compare' (duration: 74.006406ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:49:33.354427Z","caller":"traceutil/trace.go:171","msg":"trace[1695046493] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"155.394555ms","start":"2026-05-09T16:49:33.199006Z","end":"2026-05-09T16:49:33.3544Z","steps":["trace[1695046493] 'process raft request' (duration: 154.894661ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:33.354685Z","caller":"traceutil/trace.go:171","msg":"trace[2059427369] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"111.147672ms","start":"2026-05-09T16:49:33.243531Z","end":"2026-05-09T16:49:33.354678Z","steps":["trace[2059427369] 'process raft request' (duration: 110.720051ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:33.354855Z","caller":"traceutil/trace.go:171","msg":"trace[473359080] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"154.603354ms","start":"2026-05-09T16:49:33.200234Z","end":"2026-05-09T16:49:33.354838Z","steps":["trace[473359080] 'process raft request' (duration: 153.842814ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:33.355003Z","caller":"traceutil/trace.go:171","msg":"trace[1577975004] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"113.249257ms","start":"2026-05-09T16:49:33.241711Z","end":"2026-05-09T16:49:33.35496Z","steps":["trace[1577975004] 'process raft request' (duration: 112.460017ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:33.355034Z","caller":"traceutil/trace.go:171","msg":"trace[129805147] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"114.89755ms","start":"2026-05-09T16:49:33.240089Z","end":"2026-05-09T16:49:33.354987Z","steps":["trace[129805147] 'process raft request' (duration: 114.044048ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:33.543415Z","caller":"traceutil/trace.go:171","msg":"trace[1868147418] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"139.102367ms","start":"2026-05-09T16:49:33.404272Z","end":"2026-05-09T16:49:33.543374Z","steps":["trace[1868147418] 'process raft request' (duration: 86.955556ms)","trace[1868147418] 'compare' (duration: 51.988077ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:49:46.93278Z","caller":"traceutil/trace.go:171","msg":"trace[440705965] linearizableReadLoop","detail":"{readStateIndex:488; appliedIndex:487; }","duration":"300.925378ms","start":"2026-05-09T16:49:46.63182Z","end":"2026-05-09T16:49:46.932746Z","steps":["trace[440705965] 'read index received' (duration: 300.741653ms)","trace[440705965] 'applied index is now lower than readState.Index' (duration: 182.665µs)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:49:46.933002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.145934ms","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-05-09T16:49:46.933048Z","caller":"traceutil/trace.go:171","msg":"trace[1956592134] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:470; }","duration":"301.250757ms","start":"2026-05-09T16:49:46.631783Z","end":"2026-05-09T16:49:46.933034Z","steps":["trace[1956592134] 'agreement among raft nodes before linearized reading' (duration: 301.138674ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:46.933089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:46.631765Z","time spent":"301.315019ms","remote":"127.0.0.1:39288","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-05-09T16:49:46.933337Z","caller":"traceutil/trace.go:171","msg":"trace[1842762373] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"307.129589ms","start":"2026-05-09T16:49:46.625674Z","end":"2026-05-09T16:49:46.932803Z","steps":["trace[1842762373] 'process raft request' (duration: 306.843711ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:46.934131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:46.625644Z","time spent":"308.124565ms","remote":"127.0.0.1:39288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T16:49:47.308109Z","caller":"traceutil/trace.go:171","msg":"trace[1324958946] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"615.815651ms","start":"2026-05-09T16:49:46.692243Z","end":"2026-05-09T16:49:47.308058Z","steps":["trace[1324958946] 'process raft request' (duration: 615.521964ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:47.308324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:46.692223Z","time spent":"615.992115ms","remote":"127.0.0.1:39096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:49:47.308525Z","caller":"traceutil/trace.go:171","msg":"trace[1916339858] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"601.013908ms","start":"2026-05-09T16:49:46.707498Z","end":"2026-05-09T16:49:47.308512Z","steps":["trace[1916339858] 'process raft request' (duration: 600.478324ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:47.308547Z","caller":"traceutil/trace.go:171","msg":"trace[1472813042] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"594.213122ms","start":"2026-05-09T16:49:46.714298Z","end":"2026-05-09T16:49:47.308512Z","steps":["trace[1472813042] 'process raft request' (duration: 593.76153ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:47.308589Z","caller":"traceutil/trace.go:171","msg":"trace[411756300] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"585.205729ms","start":"2026-05-09T16:49:46.723356Z","end":"2026-05-09T16:49:47.308562Z","steps":["trace[411756300] 'process raft request' (duration: 584.804509ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:47.308659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:46.707461Z","time spent":"601.166772ms","remote":"127.0.0.1:39096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:49:47.308731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:46.714286Z","time spent":"594.346376ms","remote":"127.0.0.1:39096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:49:47.308691Z","caller":"traceutil/trace.go:171","msg":"trace[1432691901] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"591.203754ms","start":"2026-05-09T16:49:46.717413Z","end":"2026-05-09T16:49:47.308617Z","steps":["trace[1432691901] 'process raft request' (duration: 590.697971ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:47.30874Z","caller":"traceutil/trace.go:171","msg":"trace[54404874] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"581.927795ms","start":"2026-05-09T16:49:46.726768Z","end":"2026-05-09T16:49:47.308695Z","steps":["trace[54404874] 'process raft request' (duration: 581.531684ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:47.308756Z","caller":"traceutil/trace.go:171","msg":"trace[570231365] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"412.70118ms","start":"2026-05-09T16:49:46.89597Z","end":"2026-05-09T16:49:47.308671Z","steps":["trace[570231365] 'process raft request' (duration: 412.481464ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:47.308814Z","caller":"traceutil/trace.go:171","msg":"trace[771739908] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"588.214197ms","start":"2026-05-09T16:49:46.720588Z","end":"2026-05-09T16:49:47.308802Z","steps":["trace[771739908] 'process raft request' (duration: 587.54602ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:47.308861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:46.726735Z","time spent":"582.075488ms","remote":"127.0.0.1:39096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:49:47.308911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:46.720571Z","time spent":"588.290699ms","remote":"127.0.0.1:39096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:49:47.308922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:46.71726Z","time spent":"591.548123ms","remote":"127.0.0.1:39096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:49:47.308959Z","caller":"traceutil/trace.go:171","msg":"trace[99923063] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"600.68331ms","start":"2026-05-09T16:49:46.70825Z","end":"2026-05-09T16:49:47.308933Z","steps":["trace[99923063] 'process raft request' (duration: 599.769696ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:47.308722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:46.723344Z","time spent":"585.304381ms","remote":"127.0.0.1:39096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:49:47.309004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:46.895945Z","time spent":"412.959496ms","remote":"127.0.0.1:39096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:49:47.30882Z","caller":"traceutil/trace.go:171","msg":"trace[911940194] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"369.088763ms","start":"2026-05-09T16:49:46.939703Z","end":"2026-05-09T16:49:47.308791Z","steps":["trace[911940194] 'process raft request' (duration: 368.807966ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:47.309025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.298779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T16:49:47.308897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.304732ms","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-05-09T16:49:47.309076Z","caller":"traceutil/trace.go:171","msg":"trace[1611165445] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"611.193081ms","start":"2026-05-09T16:49:46.697869Z","end":"2026-05-09T16:49:47.309062Z","steps":["trace[1611165445] 'process raft request' (duration: 610.080212ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:47.308674Z","caller":"traceutil/trace.go:171","msg":"trace[22978714] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"107.62917ms","start":"2026-05-09T16:49:47.201033Z","end":"2026-05-09T16:49:47.308663Z","steps":["trace[22978714] 'process raft request' (duration: 107.560618ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:47.309118Z","caller":"traceutil/trace.go:171","msg":"trace[624755135] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:484; }","duration":"626.60675ms","start":"2026-05-09T16:49:46.682495Z","end":"2026-05-09T16:49:47.309102Z","steps":["trace[624755135] 'agreement among raft nodes before linearized reading' (duration: 626.257151ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:47.309116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:46.939675Z","time spent":"369.388121ms","remote":"127.0.0.1:39288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T16:49:47.309129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:46.697848Z","time spent":"611.255013ms","remote":"127.0.0.1:39096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:49:47.309114Z","caller":"traceutil/trace.go:171","msg":"trace[1533569148] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:484; }","duration":"535.419763ms","start":"2026-05-09T16:49:46.773667Z","end":"2026-05-09T16:49:47.309087Z","steps":["trace[1533569148] 'agreement among raft nodes before linearized reading' (duration: 535.280779ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:47.309167Z","caller":"traceutil/trace.go:171","msg":"trace[557439812] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"568.270622ms","start":"2026-05-09T16:49:46.740859Z","end":"2026-05-09T16:49:47.30913Z","steps":["trace[557439812] 'process raft request' (duration: 567.497162ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:47.309213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:46.773595Z","time spent":"535.611457ms","remote":"127.0.0.1:39060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T16:49:47.30901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:46.708213Z","time spent":"600.772682ms","remote":"127.0.0.1:39096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:49:47.308735Z","caller":"traceutil/trace.go:171","msg":"trace[2093332805] linearizableReadLoop","detail":"{readStateIndex:500; appliedIndex:488; }","duration":"375.827747ms","start":"2026-05-09T16:49:46.932895Z","end":"2026-05-09T16:49:47.308722Z","steps":["trace[2093332805] 'read index received' (duration: 374.931714ms)","trace[2093332805] 'applied index is now lower than readState.Index' (duration: 894.683µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:49:47.309068Z","caller":"traceutil/trace.go:171","msg":"trace[532312345] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"595.847535ms","start":"2026-05-09T16:49:46.713201Z","end":"2026-05-09T16:49:47.309049Z","steps":["trace[532312345] 'process raft request' (duration: 594.837289ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:47.309335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:46.713173Z","time spent":"596.124791ms","remote":"127.0.0.1:39096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:49:47.30917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:46.682471Z","time spent":"626.675992ms","remote":"127.0.0.1:39288","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":"warn","ts":"2026-05-09T16:49:47.309219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:46.740842Z","time spent":"568.355223ms","remote":"127.0.0.1:39096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:49:48.773153Z","caller":"traceutil/trace.go:171","msg":"trace[682721349] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:568; }","duration":"100.575814ms","start":"2026-05-09T16:49:48.672545Z","end":"2026-05-09T16:49:48.773121Z","steps":["trace[682721349] 'read index received' (duration: 100.244106ms)","trace[682721349] 'applied index is now lower than readState.Index' (duration: 330.508µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:49:48.773266Z","caller":"traceutil/trace.go:171","msg":"trace[1112306674] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"116.791163ms","start":"2026-05-09T16:49:48.656432Z","end":"2026-05-09T16:49:48.773223Z","steps":["trace[1112306674] 'process raft request' (duration: 116.406173ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:48.773445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.868492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:65436"} {"level":"info","ts":"2026-05-09T16:49:48.773497Z","caller":"traceutil/trace.go:171","msg":"trace[1533194352] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:548; }","duration":"101.000936ms","start":"2026-05-09T16:49:48.672482Z","end":"2026-05-09T16:49:48.773483Z","steps":["trace[1533194352] 'agreement among raft nodes before linearized reading' (duration: 100.77315ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:53.586376Z","caller":"traceutil/trace.go:171","msg":"trace[1016322878] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"205.622021ms","start":"2026-05-09T16:49:53.380706Z","end":"2026-05-09T16:49:53.586328Z","steps":["trace[1016322878] 'process raft request' (duration: 205.244331ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:53.586868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.807221ms","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-05-09T16:49:53.586974Z","caller":"traceutil/trace.go:171","msg":"trace[746388180] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:576; }","duration":"178.956366ms","start":"2026-05-09T16:49:53.40799Z","end":"2026-05-09T16:49:53.586947Z","steps":["trace[746388180] 'agreement among raft nodes before linearized reading' (duration: 178.510824ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:53.587119Z","caller":"traceutil/trace.go:171","msg":"trace[1307247881] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:597; }","duration":"178.254177ms","start":"2026-05-09T16:49:53.408022Z","end":"2026-05-09T16:49:53.586276Z","steps":["trace[1307247881] 'read index received' (duration: 178.037762ms)","trace[1307247881] 'applied index is now lower than readState.Index' (duration: 214.985µs)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:49:54.271375Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020295590292945,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T16:49:54.772236Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020295590292945,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T16:49:54.957818Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.198090597s","expected-duration":"1s"} {"level":"info","ts":"2026-05-09T16:49:54.95962Z","caller":"traceutil/trace.go:171","msg":"trace[2120270704] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"1.391474934s","start":"2026-05-09T16:49:53.568121Z","end":"2026-05-09T16:49:54.959596Z","steps":["trace[2120270704] 'process raft request' (duration: 1.390336114s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:54.959776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:53.568084Z","time spent":"1.391613217s","remote":"127.0.0.1:39144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036277,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T16:49:54.995081Z","caller":"traceutil/trace.go:171","msg":"trace[1854820643] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:598; }","duration":"1.223884179s","start":"2026-05-09T16:49:53.771111Z","end":"2026-05-09T16:49:54.994995Z","steps":["trace[1854820643] 'read index received' (duration: 1.187164397s)","trace[1854820643] 'applied index is now lower than readState.Index' (duration: 36.718882ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:49:54.995122Z","caller":"traceutil/trace.go:171","msg":"trace[2038592173] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"1.403788239s","start":"2026-05-09T16:49:53.59129Z","end":"2026-05-09T16:49:54.995078Z","steps":["trace[2038592173] 'process raft request' (duration: 1.403541443s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:54.995226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.224096694s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:49:54.995248Z","caller":"traceutil/trace.go:171","msg":"trace[1178373486] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:578; }","duration":"1.224177746s","start":"2026-05-09T16:49:53.771064Z","end":"2026-05-09T16:49:54.995241Z","steps":["trace[1178373486] 'agreement among raft nodes before linearized reading' (duration: 1.224122325s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:54.995267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:53.771041Z","time spent":"1.224221138s","remote":"127.0.0.1:39064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T16:49:54.995285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:53.591231Z","time spent":"1.403967483s","remote":"127.0.0.1:39288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T16:49:54.995311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.183117282s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zl9q9\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-09T16:49:54.995347Z","caller":"traceutil/trace.go:171","msg":"trace[271784346] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zl9q9; range_end:; response_count:1; response_revision:578; }","duration":"1.183212565s","start":"2026-05-09T16:49:53.812123Z","end":"2026-05-09T16:49:54.995336Z","steps":["trace[271784346] 'agreement among raft nodes before linearized reading' (duration: 1.183092981s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:54.995368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:53.812096Z","time spent":"1.183267745s","remote":"127.0.0.1:39234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-zl9q9\" "} {"level":"warn","ts":"2026-05-09T16:49:54.995476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.840484ms","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-05-09T16:49:54.99549Z","caller":"traceutil/trace.go:171","msg":"trace[587653264] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:578; }","duration":"352.904035ms","start":"2026-05-09T16:49:54.642582Z","end":"2026-05-09T16:49:54.995486Z","steps":["trace[587653264] 'agreement among raft nodes before linearized reading' (duration: 352.859724ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:54.995505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:54.642546Z","time spent":"352.955677ms","remote":"127.0.0.1:39288","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-05-09T16:49:55.508935Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020295590292948,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T16:49:56.440411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"922.806151ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T16:49:56.440656Z","caller":"traceutil/trace.go:171","msg":"trace[2072267445] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"896.419384ms","start":"2026-05-09T16:49:55.544221Z","end":"2026-05-09T16:49:56.440641Z","steps":["trace[2072267445] 'process raft request' (duration: 896.385244ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:56.440716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:55.544189Z","time spent":"896.498197ms","remote":"127.0.0.1:39288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T16:49:56.44077Z","caller":"traceutil/trace.go:171","msg":"trace[1891267403] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"1.42982014s","start":"2026-05-09T16:49:55.010921Z","end":"2026-05-09T16:49:56.440742Z","steps":["trace[1891267403] 'process raft request' (duration: 1.429602644s)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:56.440913Z","caller":"traceutil/trace.go:171","msg":"trace[1741056352] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:600; }","duration":"1.432161779s","start":"2026-05-09T16:49:55.00874Z","end":"2026-05-09T16:49:56.440902Z","steps":["trace[1741056352] 'read index received' (duration: 508.861176ms)","trace[1741056352] 'applied index is now lower than readState.Index' (duration: 923.299453ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:49:56.440945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:55.010906Z","time spent":"1.429927282s","remote":"127.0.0.1:39234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T16:49:56.441064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.432310594s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:49:56.441151Z","caller":"traceutil/trace.go:171","msg":"trace[75110725] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:582; }","duration":"1.432417406s","start":"2026-05-09T16:49:55.008712Z","end":"2026-05-09T16:49:56.44113Z","steps":["trace[75110725] 'agreement among raft nodes before linearized reading' (duration: 1.432246612s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:56.441094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.393358175s","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-05-09T16:49:56.441198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.305869462s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.38\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-05-09T16:49:56.441203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:55.008699Z","time spent":"1.432493629s","remote":"127.0.0.1:39060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-09T16:49:56.441219Z","caller":"traceutil/trace.go:171","msg":"trace[1475305606] range","detail":"{range_begin:/registry/masterleases/199.204.45.38; range_end:; response_count:1; response_revision:582; }","duration":"1.305934914s","start":"2026-05-09T16:49:55.135277Z","end":"2026-05-09T16:49:56.441212Z","steps":["trace[1475305606] 'agreement among raft nodes before linearized reading' (duration: 1.305898573s)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:56.441228Z","caller":"traceutil/trace.go:171","msg":"trace[1735307652] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:582; }","duration":"1.393509049s","start":"2026-05-09T16:49:55.047698Z","end":"2026-05-09T16:49:56.441207Z","steps":["trace[1735307652] 'agreement among raft nodes before linearized reading' (duration: 1.393286323s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:56.441249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:55.135243Z","time spent":"1.306000585s","remote":"127.0.0.1:39072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.204.45.38\" "} {"level":"warn","ts":"2026-05-09T16:49:56.441162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"849.725897ms","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-05-09T16:49:56.441292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:55.047684Z","time spent":"1.393592051s","remote":"127.0.0.1:39288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-09T16:49:56.44131Z","caller":"traceutil/trace.go:171","msg":"trace[240760737] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:582; }","duration":"849.920182ms","start":"2026-05-09T16:49:55.59138Z","end":"2026-05-09T16:49:56.441301Z","steps":["trace[240760737] 'agreement among raft nodes before linearized reading' (duration: 849.737038ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:56.44134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:55.591351Z","time spent":"849.980224ms","remote":"127.0.0.1:39288","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-05-09T16:49:56.441333Z","caller":"traceutil/trace.go:171","msg":"trace[534380902] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"1.440186256s","start":"2026-05-09T16:49:55.001094Z","end":"2026-05-09T16:49:56.44128Z","steps":["trace[534380902] 'process raft request' (duration: 516.419031ms)","trace[534380902] 'compare' (duration: 922.662566ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:49:56.441425Z","caller":"traceutil/trace.go:171","msg":"trace[971215186] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"1.416709523s","start":"2026-05-09T16:49:55.024051Z","end":"2026-05-09T16:49:56.44076Z","steps":["trace[971215186] 'process raft request' (duration: 1.416521989s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:56.441531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:55.001078Z","time spent":"1.440334789s","remote":"127.0.0.1:39288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T16:49:56.44159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:55.024033Z","time spent":"1.417475473s","remote":"127.0.0.1:39522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:49:57.185273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.293342ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"warn","ts":"2026-05-09T16:49:57.185397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:56.44301Z","time spent":"742.381356ms","remote":"127.0.0.1:39072","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-09T16:49:57.237201Z","caller":"traceutil/trace.go:171","msg":"trace[643185624] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:604; }","duration":"785.445577ms","start":"2026-05-09T16:49:56.451732Z","end":"2026-05-09T16:49:57.237178Z","steps":["trace[643185624] 'read index received' (duration: 235.38453ms)","trace[643185624] 'applied index is now lower than readState.Index' (duration: 550.060177ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:49:57.237356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"785.590801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:49:57.237389Z","caller":"traceutil/trace.go:171","msg":"trace[245959169] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:584; }","duration":"785.678793ms","start":"2026-05-09T16:49:56.451701Z","end":"2026-05-09T16:49:57.23738Z","steps":["trace[245959169] 'agreement among raft nodes before linearized reading' (duration: 785.592821ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:57.237343Z","caller":"traceutil/trace.go:171","msg":"trace[1249399026] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"790.733663ms","start":"2026-05-09T16:49:56.446558Z","end":"2026-05-09T16:49:57.237292Z","steps":["trace[1249399026] 'process raft request' (duration: 790.396444ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:57.237426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:56.451691Z","time spent":"785.725424ms","remote":"127.0.0.1:39060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T16:49:57.237648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:56.446532Z","time spent":"790.956369ms","remote":"127.0.0.1:39288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T16:49:57.237554Z","caller":"traceutil/trace.go:171","msg":"trace[1405352215] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"790.839616ms","start":"2026-05-09T16:49:56.446647Z","end":"2026-05-09T16:49:57.237487Z","steps":["trace[1405352215] 'process raft request' (duration: 790.494557ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:57.237977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:56.446642Z","time spent":"791.106333ms","remote":"127.0.0.1:39288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T16:49:57.2413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"789.241374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:49:57.241349Z","caller":"traceutil/trace.go:171","msg":"trace[1584390773] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:585; }","duration":"789.289786ms","start":"2026-05-09T16:49:56.452045Z","end":"2026-05-09T16:49:57.241335Z","steps":["trace[1584390773] 'agreement among raft nodes before linearized reading' (duration: 789.189053ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:49:57.241376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:49:56.452023Z","time spent":"789.347088ms","remote":"127.0.0.1:39272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-05-09T16:49:57.241644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.631196ms","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-05-09T16:49:57.241748Z","caller":"traceutil/trace.go:171","msg":"trace[384081047] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:585; }","duration":"241.747689ms","start":"2026-05-09T16:49:56.999983Z","end":"2026-05-09T16:49:57.24173Z","steps":["trace[384081047] 'agreement among raft nodes before linearized reading' (duration: 241.475582ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:49:59.156377Z","caller":"traceutil/trace.go:171","msg":"trace[646878182] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"165.374174ms","start":"2026-05-09T16:49:58.99097Z","end":"2026-05-09T16:49:59.156344Z","steps":["trace[646878182] 'process raft request' (duration: 165.232349ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:50:02.204934Z","caller":"traceutil/trace.go:171","msg":"trace[127843907] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"190.642544ms","start":"2026-05-09T16:50:02.014229Z","end":"2026-05-09T16:50:02.204871Z","steps":["trace[127843907] 'process raft request' (duration: 190.385245ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:50:16.936366Z","caller":"traceutil/trace.go:171","msg":"trace[1725485847] linearizableReadLoop","detail":"{readStateIndex:784; appliedIndex:783; }","duration":"396.386355ms","start":"2026-05-09T16:50:16.539957Z","end":"2026-05-09T16:50:16.936343Z","steps":["trace[1725485847] 'read index received' (duration: 396.181548ms)","trace[1725485847] 'applied index is now lower than readState.Index' (duration: 203.937µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:50:16.936483Z","caller":"traceutil/trace.go:171","msg":"trace[7698146] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"966.957201ms","start":"2026-05-09T16:50:15.969499Z","end":"2026-05-09T16:50:16.936456Z","steps":["trace[7698146] 'process raft request' (duration: 966.717523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:50:16.936581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.627304ms","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-05-09T16:50:16.936626Z","caller":"traceutil/trace.go:171","msg":"trace[557287839] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:756; }","duration":"396.719467ms","start":"2026-05-09T16:50:16.539894Z","end":"2026-05-09T16:50:16.936614Z","steps":["trace[557287839] 'agreement among raft nodes before linearized reading' (duration: 396.586432ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:50:16.936632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:50:15.969477Z","time spent":"967.074906ms","remote":"127.0.0.1:39234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4024,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T16:50:16.936663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:50:16.539872Z","time spent":"396.782219ms","remote":"127.0.0.1:39288","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-05-09T16:50:16.936756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.246393ms","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-05-09T16:50:16.936799Z","caller":"traceutil/trace.go:171","msg":"trace[151235153] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:756; }","duration":"239.329107ms","start":"2026-05-09T16:50:16.697461Z","end":"2026-05-09T16:50:16.93679Z","steps":["trace[151235153] 'agreement among raft nodes before linearized reading' (duration: 239.233063ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:52:44.394408Z","caller":"traceutil/trace.go:171","msg":"trace[694507256] transaction","detail":"{read_only:false; response_revision:1416; number_of_response:1; }","duration":"111.935027ms","start":"2026-05-09T16:52:44.28242Z","end":"2026-05-09T16:52:44.394355Z","steps":["trace[694507256] 'process raft request' (duration: 78.865392ms)","trace[694507256] 'compare' (duration: 32.365506ms)"],"step_count":2}