{"level":"warn","ts":"2026-03-31T20:14:42.028224Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-31T20:14:42.028336Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.210: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.210:2380","--initial-cluster=instance=https://199.204.45.210:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.210:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.210: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-03-31T20:14:42.028436Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-31T20:14:42.028448Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-03-31T20:14:42.028471Z","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-03-31T20:14:42.029905Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"]} {"level":"info","ts":"2026-03-31T20:14:42.030059Z","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.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.210: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-03-31T20:14:42.035438Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.089849ms"} {"level":"info","ts":"2026-03-31T20:14:42.044887Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1cac722af8b2b8a6","cluster-id":"ba0a336ca61ee41d"} {"level":"info","ts":"2026-03-31T20:14:42.044961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=()"} {"level":"info","ts":"2026-03-31T20:14:42.045025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 0"} {"level":"info","ts":"2026-03-31T20:14:42.045073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1cac722af8b2b8a6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-31T20:14:42.045089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 1"} {"level":"info","ts":"2026-03-31T20:14:42.045124Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"warn","ts":"2026-03-31T20:14:42.059993Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-31T20:14:42.062627Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-31T20:14:42.063677Z","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-03-31T20:14:42.065768Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1cac722af8b2b8a6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-31T20:14:42.065973Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1cac722af8b2b8a6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-31T20:14:42.066259Z","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-03-31T20:14:42.066361Z","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-03-31T20:14:42.066377Z","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-03-31T20:14:42.069728Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"info","ts":"2026-03-31T20:14:42.070245Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","added-peer-id":"1cac722af8b2b8a6","added-peer-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-03-31T20:14:42.070917Z","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-03-31T20:14:42.071057Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-03-31T20:14:42.071121Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-03-31T20:14:42.071179Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1cac722af8b2b8a6","initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-31T20:14:42.071206Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-31T20:14:42.249044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 is starting a new election at term 1"} {"level":"info","ts":"2026-03-31T20:14:42.249127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-31T20:14:42.24916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgPreVoteResp from 1cac722af8b2b8a6 at term 1"} {"level":"info","ts":"2026-03-31T20:14:42.249175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became candidate at term 2"} {"level":"info","ts":"2026-03-31T20:14:42.249181Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgVoteResp from 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-03-31T20:14:42.249192Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became leader at term 2"} {"level":"info","ts":"2026-03-31T20:14:42.249202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1cac722af8b2b8a6 elected leader 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-03-31T20:14:42.257293Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T20:14:42.265267Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-31T20:14:42.265267Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1cac722af8b2b8a6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.210:2379]}","request-path":"/0/members/1cac722af8b2b8a6/attributes","cluster-id":"ba0a336ca61ee41d","publish-timeout":"7s"} {"level":"info","ts":"2026-03-31T20:14:42.265339Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-31T20:14:42.266258Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T20:14:42.266418Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T20:14:42.266553Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-31T20:14:42.266576Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-31T20:14:42.266583Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T20:14:42.268957Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.210:2379"} {"level":"info","ts":"2026-03-31T20:14:42.271898Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-03-31T20:14:44.369433Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495071085002101,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-31T20:14:44.397654Z","caller":"traceutil/trace.go:171","msg":"trace[166363221] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"533.432832ms","start":"2026-03-31T20:14:43.864186Z","end":"2026-03-31T20:14:44.397619Z","steps":["trace[166363221] 'process raft request' (duration: 533.178001ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:44.398478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:43.864174Z","time spent":"533.603619ms","remote":"127.0.0.1:60968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T20:14:45.599273Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.201991609s","expected-duration":"1s"} {"level":"info","ts":"2026-03-31T20:14:45.621752Z","caller":"traceutil/trace.go:171","msg":"trace[1599297] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:4; }","duration":"1.752956445s","start":"2026-03-31T20:14:43.868763Z","end":"2026-03-31T20:14:45.621719Z","steps":["trace[1599297] 'read index received' (duration: 528.580224ms)","trace[1599297] 'applied index is now lower than readState.Index' (duration: 1.224375101s)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:14:45.621922Z","caller":"traceutil/trace.go:171","msg":"trace[472224843] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"1.668894268s","start":"2026-03-31T20:14:43.953018Z","end":"2026-03-31T20:14:45.621912Z","steps":["trace[472224843] 'process raft request' (duration: 1.668545183s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:45.622038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:43.952998Z","time spent":"1.668966431s","remote":"127.0.0.1:33166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T20:14:45.622327Z","caller":"traceutil/trace.go:171","msg":"trace[1986501526] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.663382642s","start":"2026-03-31T20:14:43.958936Z","end":"2026-03-31T20:14:45.622319Z","steps":["trace[1986501526] 'process raft request' (duration: 1.662745704s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:45.622433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:43.958929Z","time spent":"1.663472325s","remote":"127.0.0.1:32832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T20:14:45.621827Z","caller":"traceutil/trace.go:171","msg":"trace[1312430656] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"1.668912978s","start":"2026-03-31T20:14:43.952867Z","end":"2026-03-31T20:14:45.62178Z","steps":["trace[1312430656] 'process raft request' (duration: 1.668669578s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:45.62375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:43.952858Z","time spent":"1.670867543s","remote":"127.0.0.1:33166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T20:14:45.622509Z","caller":"traceutil/trace.go:171","msg":"trace[2001968801] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"1.666677772s","start":"2026-03-31T20:14:43.955778Z","end":"2026-03-31T20:14:45.622456Z","steps":["trace[2001968801] 'process raft request' (duration: 1.665840327s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:45.623902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:43.955771Z","time spent":"1.668109884s","remote":"127.0.0.1:32912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T20:14:45.622694Z","caller":"traceutil/trace.go:171","msg":"trace[1660500812] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"1.670064658s","start":"2026-03-31T20:14:43.952616Z","end":"2026-03-31T20:14:45.62268Z","steps":["trace[1660500812] 'process raft request' (duration: 1.668816805s)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:45.622733Z","caller":"traceutil/trace.go:171","msg":"trace[678671868] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"1.671383075s","start":"2026-03-31T20:14:43.951334Z","end":"2026-03-31T20:14:45.622717Z","steps":["trace[678671868] 'process raft request' (duration: 1.64827484s)","trace[678671868] 'compare' (duration: 21.58619ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:14:45.6242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:43.952601Z","time spent":"1.671454998s","remote":"127.0.0.1:33166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-31T20:14:45.624351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:43.951311Z","time spent":"1.672969603s","remote":"127.0.0.1:33074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T20:14:45.622749Z","caller":"traceutil/trace.go:171","msg":"trace[1459843633] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"1.669935873s","start":"2026-03-31T20:14:43.952803Z","end":"2026-03-31T20:14:45.622739Z","steps":["trace[1459843633] 'process raft request' (duration: 1.668703459s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:45.623014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.753891017s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-03-31T20:14:45.624735Z","caller":"traceutil/trace.go:171","msg":"trace[1018330357] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"1.755661782s","start":"2026-03-31T20:14:43.869054Z","end":"2026-03-31T20:14:45.624716Z","steps":["trace[1018330357] 'agreement among raft nodes before linearized reading' (duration: 1.75373977s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:45.623078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.612894215s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-03-31T20:14:45.624799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:43.869011Z","time spent":"1.755773928s","remote":"127.0.0.1:32832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3194,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-03-31T20:14:45.624826Z","caller":"traceutil/trace.go:171","msg":"trace[683696272] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.614666901s","start":"2026-03-31T20:14:44.01013Z","end":"2026-03-31T20:14:45.624797Z","steps":["trace[683696272] 'agreement among raft nodes before linearized reading' (duration: 1.612839532s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:45.624898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:44.010119Z","time spent":"1.614759715s","remote":"127.0.0.1:32776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-03-31T20:14:45.623079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.619431655s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-31T20:14:45.625103Z","caller":"traceutil/trace.go:171","msg":"trace[1450446023] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.621478963s","start":"2026-03-31T20:14:44.003613Z","end":"2026-03-31T20:14:45.625092Z","steps":["trace[1450446023] 'agreement among raft nodes before linearized reading' (duration: 1.619444985s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:45.625144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:44.003602Z","time spent":"1.621531245s","remote":"127.0.0.1:32776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-03-31T20:14:45.623132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.754366697s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-31T20:14:45.625267Z","caller":"traceutil/trace.go:171","msg":"trace[645683991] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:10; }","duration":"1.756503358s","start":"2026-03-31T20:14:43.86875Z","end":"2026-03-31T20:14:45.625253Z","steps":["trace[645683991] 'agreement among raft nodes before linearized reading' (duration: 1.754359305s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:45.625321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:43.868738Z","time spent":"1.756565882s","remote":"127.0.0.1:60964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-03-31T20:14:45.623153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.669895121s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-31T20:14:45.625408Z","caller":"traceutil/trace.go:171","msg":"trace[227173906] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.672154478s","start":"2026-03-31T20:14:43.953242Z","end":"2026-03-31T20:14:45.625396Z","steps":["trace[227173906] 'agreement among raft nodes before linearized reading' (duration: 1.669884581s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:45.625452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:43.953236Z","time spent":"1.67220567s","remote":"127.0.0.1:32776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-03-31T20:14:45.623176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.390756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-31T20:14:45.625552Z","caller":"traceutil/trace.go:171","msg":"trace[1555906556] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:10; }","duration":"379.794601ms","start":"2026-03-31T20:14:45.245746Z","end":"2026-03-31T20:14:45.625541Z","steps":["trace[1555906556] 'agreement among raft nodes before linearized reading' (duration: 377.405889ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:45.625592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:45.245721Z","time spent":"379.861783ms","remote":"127.0.0.1:60920","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-03-31T20:14:45.623218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"778.654322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-31T20:14:45.625679Z","caller":"traceutil/trace.go:171","msg":"trace[68369451] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:10; }","duration":"781.16822ms","start":"2026-03-31T20:14:44.844498Z","end":"2026-03-31T20:14:45.625667Z","steps":["trace[68369451] 'agreement among raft nodes before linearized reading' (duration: 778.696023ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:45.625724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:44.84447Z","time spent":"781.243164ms","remote":"127.0.0.1:33026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-03-31T20:14:45.623257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.67685329s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-31T20:14:45.62585Z","caller":"traceutil/trace.go:171","msg":"trace[1984953983] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"1.679520425s","start":"2026-03-31T20:14:43.946307Z","end":"2026-03-31T20:14:45.625828Z","steps":["trace[1984953983] 'agreement among raft nodes before linearized reading' (duration: 1.67686254s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:45.625895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:43.946296Z","time spent":"1.679587547s","remote":"127.0.0.1:60984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-03-31T20:14:45.623271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"778.876281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-31T20:14:45.625952Z","caller":"traceutil/trace.go:171","msg":"trace[785454876] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:10; }","duration":"781.553117ms","start":"2026-03-31T20:14:44.844386Z","end":"2026-03-31T20:14:45.62594Z","steps":["trace[785454876] 'agreement among raft nodes before linearized reading' (duration: 778.853641ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:45.626001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:44.8443Z","time spent":"781.685521ms","remote":"127.0.0.1:33012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-03-31T20:14:45.623294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.67967104s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.210\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-31T20:14:45.626129Z","caller":"traceutil/trace.go:171","msg":"trace[174416998] range","detail":"{range_begin:/registry/masterleases/199.204.45.210; range_end:; response_count:0; response_revision:10; }","duration":"1.682540535s","start":"2026-03-31T20:14:43.943578Z","end":"2026-03-31T20:14:45.626118Z","steps":["trace[174416998] 'agreement among raft nodes before linearized reading' (duration: 1.679697493s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:45.626172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:43.943552Z","time spent":"1.682608857s","remote":"127.0.0.1:60948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.210\" "} {"level":"info","ts":"2026-03-31T20:14:45.622368Z","caller":"traceutil/trace.go:171","msg":"trace[553108630] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"1.669337886s","start":"2026-03-31T20:14:43.952995Z","end":"2026-03-31T20:14:45.622333Z","steps":["trace[553108630] 'process raft request' (duration: 1.668586854s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:45.626255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:43.952928Z","time spent":"1.673290857s","remote":"127.0.0.1:33166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-31T20:14:45.626272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:43.952775Z","time spent":"1.672764294s","remote":"127.0.0.1:33166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-31T20:14:46.132561Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495071085002113,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-31T20:14:46.507664Z","caller":"traceutil/trace.go:171","msg":"trace[2034574230] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"875.579965ms","start":"2026-03-31T20:14:45.632036Z","end":"2026-03-31T20:14:46.507616Z","steps":["trace[2034574230] 'process raft request' (duration: 875.288533ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:46.507885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:45.632009Z","time spent":"875.745033ms","remote":"127.0.0.1:33074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T20:14:46.53935Z","caller":"traceutil/trace.go:171","msg":"trace[331126690] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"907.068554ms","start":"2026-03-31T20:14:45.632262Z","end":"2026-03-31T20:14:46.539331Z","steps":["trace[331126690] 'process raft request' (duration: 906.819932ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:46.539385Z","caller":"traceutil/trace.go:171","msg":"trace[1782293990] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"907.094604ms","start":"2026-03-31T20:14:45.632237Z","end":"2026-03-31T20:14:46.539331Z","steps":["trace[1782293990] 'process raft request' (duration: 906.805621ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:46.539453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:45.632247Z","time spent":"907.155996ms","remote":"127.0.0.1:33166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T20:14:46.539492Z","caller":"traceutil/trace.go:171","msg":"trace[1314105712] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"907.123355ms","start":"2026-03-31T20:14:45.632354Z","end":"2026-03-31T20:14:46.539478Z","steps":["trace[1314105712] 'process raft request' (duration: 906.868644ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:46.539592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:45.63221Z","time spent":"907.285171ms","remote":"127.0.0.1:32776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T20:14:46.539642Z","caller":"traceutil/trace.go:171","msg":"trace[2045933861] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"907.316244ms","start":"2026-03-31T20:14:45.632317Z","end":"2026-03-31T20:14:46.539633Z","steps":["trace[2045933861] 'process raft request' (duration: 906.835523ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:46.539689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:45.63231Z","time spent":"907.354715ms","remote":"127.0.0.1:33042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T20:14:46.539718Z","caller":"traceutil/trace.go:171","msg":"trace[676356335] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"907.356835ms","start":"2026-03-31T20:14:45.632331Z","end":"2026-03-31T20:14:46.539688Z","steps":["trace[676356335] 'process raft request' (duration: 906.853233ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:46.539826Z","caller":"traceutil/trace.go:171","msg":"trace[580819682] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"906.30259ms","start":"2026-03-31T20:14:45.633508Z","end":"2026-03-31T20:14:46.539811Z","steps":["trace[580819682] 'process raft request' (duration: 905.810149ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:46.539907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:45.63232Z","time spent":"907.496031ms","remote":"127.0.0.1:33166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-31T20:14:46.539924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:45.633502Z","time spent":"906.374613ms","remote":"127.0.0.1:33026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T20:14:46.539793Z","caller":"traceutil/trace.go:171","msg":"trace[1324694859] linearizableReadLoop","detail":"{readStateIndex:25; appliedIndex:13; }","duration":"907.24514ms","start":"2026-03-31T20:14:45.632335Z","end":"2026-03-31T20:14:46.53958Z","steps":["trace[1324694859] 'read index received' (duration: 875.140926ms)","trace[1324694859] 'applied index is now lower than readState.Index' (duration: 32.102744ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:14:46.540106Z","caller":"traceutil/trace.go:171","msg":"trace[38578811] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"907.719191ms","start":"2026-03-31T20:14:45.632374Z","end":"2026-03-31T20:14:46.540093Z","steps":["trace[38578811] 'process raft request' (duration: 906.902826ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:46.540124Z","caller":"traceutil/trace.go:171","msg":"trace[1484870231] transaction","detail":"{read_only:false; number_of_response:0; response_revision:20; }","duration":"905.8563ms","start":"2026-03-31T20:14:45.634221Z","end":"2026-03-31T20:14:46.540077Z","steps":["trace[1484870231] 'process raft request' (duration: 905.143659ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:46.54017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:45.632349Z","time spent":"907.784524ms","remote":"127.0.0.1:33166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-31T20:14:46.539601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:45.632326Z","time spent":"907.205578ms","remote":"127.0.0.1:33166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T20:14:46.539407Z","caller":"traceutil/trace.go:171","msg":"trace[714504359] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"907.062422ms","start":"2026-03-31T20:14:45.632307Z","end":"2026-03-31T20:14:46.539369Z","steps":["trace[714504359] 'process raft request' (duration: 906.813911ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:46.540116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.765892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-n9ft5\" ","response":"range_response_count:1 size:857"} {"level":"warn","ts":"2026-03-31T20:14:46.540315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:45.632301Z","time spent":"907.982982ms","remote":"127.0.0.1:33166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T20:14:46.540409Z","caller":"traceutil/trace.go:171","msg":"trace[2016818210] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-n9ft5; range_end:; response_count:1; response_revision:21; }","duration":"908.107068ms","start":"2026-03-31T20:14:45.632287Z","end":"2026-03-31T20:14:46.540395Z","steps":["trace[2016818210] 'agreement among raft nodes before linearized reading' (duration: 907.570174ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:46.540284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:45.634185Z","time spent":"906.025148ms","remote":"127.0.0.1:32776","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T20:14:46.540455Z","caller":"traceutil/trace.go:171","msg":"trace[1757611071] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"903.043219ms","start":"2026-03-31T20:14:45.6374Z","end":"2026-03-31T20:14:46.540443Z","steps":["trace[1757611071] 'process raft request' (duration: 902.024166ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:46.540525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:45.632229Z","time spent":"908.258425ms","remote":"127.0.0.1:32912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":880,"request content":"key:\"/registry/certificatesigningrequests/csr-n9ft5\" "} {"level":"info","ts":"2026-03-31T20:14:46.539235Z","caller":"traceutil/trace.go:171","msg":"trace[1787854015] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"907.010551ms","start":"2026-03-31T20:14:45.632202Z","end":"2026-03-31T20:14:46.539212Z","steps":["trace[1787854015] 'process raft request' (duration: 906.681046ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:46.540764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:45.632194Z","time spent":"908.511255ms","remote":"127.0.0.1:60964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T20:14:46.540534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:45.637392Z","time spent":"903.099752ms","remote":"127.0.0.1:32832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3479,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T20:14:46.558548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"924.013503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-03-31T20:14:46.558563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"924.996776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-31T20:14:46.558614Z","caller":"traceutil/trace.go:171","msg":"trace[31742651] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:22; }","duration":"924.095977ms","start":"2026-03-31T20:14:45.634504Z","end":"2026-03-31T20:14:46.5586Z","steps":["trace[31742651] 'agreement among raft nodes before linearized reading' (duration: 923.987473ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:46.558642Z","caller":"traceutil/trace.go:171","msg":"trace[1828789464] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22; }","duration":"925.264106ms","start":"2026-03-31T20:14:45.633364Z","end":"2026-03-31T20:14:46.558628Z","steps":["trace[1828789464] 'agreement among raft nodes before linearized reading' (duration: 925.162292ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:46.558655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:45.634497Z","time spent":"924.150579ms","remote":"127.0.0.1:33012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:aggregate-to-admin\" "} {"level":"warn","ts":"2026-03-31T20:14:46.558686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:45.633357Z","time spent":"925.32444ms","remote":"127.0.0.1:60904","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-03-31T20:14:46.559069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"866.543829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-03-31T20:14:46.559183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.265946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-31T20:14:46.55925Z","caller":"traceutil/trace.go:171","msg":"trace[337028697] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:22; }","duration":"728.385812ms","start":"2026-03-31T20:14:45.830845Z","end":"2026-03-31T20:14:46.559231Z","steps":["trace[337028697] 'agreement among raft nodes before linearized reading' (duration: 727.563646ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:46.559287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:45.830741Z","time spent":"728.537758ms","remote":"127.0.0.1:32918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"info","ts":"2026-03-31T20:14:46.559213Z","caller":"traceutil/trace.go:171","msg":"trace[1297676515] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:22; }","duration":"867.232849ms","start":"2026-03-31T20:14:45.691911Z","end":"2026-03-31T20:14:46.559144Z","steps":["trace[1297676515] 'agreement among raft nodes before linearized reading' (duration: 866.509097ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:46.559501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:45.691897Z","time spent":"867.589304ms","remote":"127.0.0.1:32776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-03-31T20:14:46.931188Z","caller":"traceutil/trace.go:171","msg":"trace[1343532705] transaction","detail":"{read_only:false; response_revision:58; number_of_response:1; }","duration":"119.770954ms","start":"2026-03-31T20:14:46.811386Z","end":"2026-03-31T20:14:46.931157Z","steps":["trace[1343532705] 'process raft request' (duration: 106.652238ms)","trace[1343532705] 'compare' (duration: 12.683397ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:14:46.931668Z","caller":"traceutil/trace.go:171","msg":"trace[781595029] transaction","detail":"{read_only:false; response_revision:59; number_of_response:1; }","duration":"119.898109ms","start":"2026-03-31T20:14:46.811713Z","end":"2026-03-31T20:14:46.931611Z","steps":["trace[781595029] 'process raft request' (duration: 119.128086ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:46.93191Z","caller":"traceutil/trace.go:171","msg":"trace[957609531] transaction","detail":"{read_only:false; response_revision:60; number_of_response:1; }","duration":"108.847112ms","start":"2026-03-31T20:14:46.822683Z","end":"2026-03-31T20:14:46.93153Z","steps":["trace[957609531] 'process raft request' (duration: 108.208106ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:47.150656Z","caller":"traceutil/trace.go:171","msg":"trace[292231830] linearizableReadLoop","detail":"{readStateIndex:77; appliedIndex:75; }","duration":"124.937633ms","start":"2026-03-31T20:14:47.02569Z","end":"2026-03-31T20:14:47.150628Z","steps":["trace[292231830] 'read index received' (duration: 81.79572ms)","trace[292231830] 'applied index is now lower than readState.Index' (duration: 43.140673ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:14:47.150819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.104421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/kube-controller-manager\" ","response":"range_response_count:1 size:1128"} {"level":"info","ts":"2026-03-31T20:14:47.150869Z","caller":"traceutil/trace.go:171","msg":"trace[1279815050] range","detail":"{range_begin:/registry/flowschemas/kube-controller-manager; range_end:; response_count:1; response_revision:73; }","duration":"125.184464ms","start":"2026-03-31T20:14:47.025661Z","end":"2026-03-31T20:14:47.150846Z","steps":["trace[1279815050] 'agreement among raft nodes before linearized reading' (duration: 125.069609ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:47.150864Z","caller":"traceutil/trace.go:171","msg":"trace[345083632] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"126.218929ms","start":"2026-03-31T20:14:47.024566Z","end":"2026-03-31T20:14:47.150785Z","steps":["trace[345083632] 'process raft request' (duration: 82.990393ms)","trace[345083632] 'compare' (duration: 42.86135ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:14:47.150851Z","caller":"traceutil/trace.go:171","msg":"trace[1949219500] transaction","detail":"{read_only:false; response_revision:73; number_of_response:1; }","duration":"126.217399ms","start":"2026-03-31T20:14:47.024592Z","end":"2026-03-31T20:14:47.150809Z","steps":["trace[1949219500] 'process raft request' (duration: 125.984608ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:47.373314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.292466ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-03-31T20:14:47.373575Z","caller":"traceutil/trace.go:171","msg":"trace[937480126] transaction","detail":"{read_only:false; response_revision:76; number_of_response:1; }","duration":"215.967294ms","start":"2026-03-31T20:14:47.157585Z","end":"2026-03-31T20:14:47.373553Z","steps":["trace[937480126] 'process raft request' (duration: 215.871979ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:47.3736Z","caller":"traceutil/trace.go:171","msg":"trace[1526017685] transaction","detail":"{read_only:false; response_revision:75; number_of_response:1; }","duration":"218.286844ms","start":"2026-03-31T20:14:47.155269Z","end":"2026-03-31T20:14:47.373556Z","steps":["trace[1526017685] 'process raft request' (duration: 102.420622ms)","trace[1526017685] 'compare' (duration: 115.079068ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:14:47.383017Z","caller":"traceutil/trace.go:171","msg":"trace[1294530888] transaction","detail":"{read_only:false; response_revision:77; number_of_response:1; }","duration":"129.48709ms","start":"2026-03-31T20:14:47.253478Z","end":"2026-03-31T20:14:47.382965Z","steps":["trace[1294530888] 'process raft request' (duration: 129.302233ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:47.577772Z","caller":"traceutil/trace.go:171","msg":"trace[757363409] transaction","detail":"{read_only:false; response_revision:80; number_of_response:1; }","duration":"192.03312ms","start":"2026-03-31T20:14:47.385702Z","end":"2026-03-31T20:14:47.577735Z","steps":["trace[757363409] 'process raft request' (duration: 191.980538ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:47.57784Z","caller":"traceutil/trace.go:171","msg":"trace[1482512083] transaction","detail":"{read_only:false; response_revision:79; number_of_response:1; }","duration":"192.201157ms","start":"2026-03-31T20:14:47.385597Z","end":"2026-03-31T20:14:47.577799Z","steps":["trace[1482512083] 'process raft request' (duration: 145.460849ms)","trace[1482512083] 'compare' (duration: 46.483247ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:14:47.580512Z","caller":"traceutil/trace.go:171","msg":"trace[674893569] transaction","detail":"{read_only:false; response_revision:82; number_of_response:1; }","duration":"146.297115ms","start":"2026-03-31T20:14:47.434204Z","end":"2026-03-31T20:14:47.580501Z","steps":["trace[674893569] 'process raft request' (duration: 146.245533ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:47.580658Z","caller":"traceutil/trace.go:171","msg":"trace[962479448] transaction","detail":"{read_only:false; response_revision:81; number_of_response:1; }","duration":"147.920146ms","start":"2026-03-31T20:14:47.432723Z","end":"2026-03-31T20:14:47.580643Z","steps":["trace[962479448] 'process raft request' (duration: 147.621953ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:47.888687Z","caller":"traceutil/trace.go:171","msg":"trace[321715484] transaction","detail":"{read_only:false; response_revision:92; number_of_response:1; }","duration":"104.492512ms","start":"2026-03-31T20:14:47.784155Z","end":"2026-03-31T20:14:47.888647Z","steps":["trace[321715484] 'process raft request' (duration: 66.414677ms)","trace[321715484] 'compare' (duration: 37.899217ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:14:49.596841Z","caller":"traceutil/trace.go:171","msg":"trace[373354615] transaction","detail":"{read_only:false; response_revision:197; number_of_response:1; }","duration":"169.869782ms","start":"2026-03-31T20:14:49.426934Z","end":"2026-03-31T20:14:49.596804Z","steps":["trace[373354615] 'process raft request' (duration: 94.097963ms)","trace[373354615] 'compare' (duration: 75.531229ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:14:49.911285Z","caller":"traceutil/trace.go:171","msg":"trace[1445014765] transaction","detail":"{read_only:false; response_revision:208; number_of_response:1; }","duration":"112.458347ms","start":"2026-03-31T20:14:49.798785Z","end":"2026-03-31T20:14:49.911244Z","steps":["trace[1445014765] 'process raft request' (duration: 85.215948ms)","trace[1445014765] 'compare' (duration: 27.081873ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:14:49.912116Z","caller":"traceutil/trace.go:171","msg":"trace[236377078] transaction","detail":"{read_only:false; response_revision:209; number_of_response:1; }","duration":"111.894143ms","start":"2026-03-31T20:14:49.800191Z","end":"2026-03-31T20:14:49.912085Z","steps":["trace[236377078] 'process raft request' (duration: 111.756137ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:50.594077Z","caller":"traceutil/trace.go:171","msg":"trace[878406210] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"160.910153ms","start":"2026-03-31T20:14:50.433144Z","end":"2026-03-31T20:14:50.594054Z","steps":["trace[878406210] 'process raft request' (duration: 160.782238ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:52.133477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.670747ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-31T20:14:52.133705Z","caller":"traceutil/trace.go:171","msg":"trace[1531464894] linearizableReadLoop","detail":"{readStateIndex:303; appliedIndex:301; }","duration":"220.968772ms","start":"2026-03-31T20:14:51.912714Z","end":"2026-03-31T20:14:52.133683Z","steps":["trace[1531464894] 'read index received' (duration: 18.980883ms)","trace[1531464894] 'applied index is now lower than readState.Index' (duration: 201.986519ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:14:52.133787Z","caller":"traceutil/trace.go:171","msg":"trace[1465480475] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"222.100102ms","start":"2026-03-31T20:14:51.911674Z","end":"2026-03-31T20:14:52.133774Z","steps":["trace[1465480475] 'process raft request' (duration: 20.04618ms)","trace[1465480475] 'compare' (duration: 201.484348ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:14:52.133831Z","caller":"traceutil/trace.go:171","msg":"trace[529643944] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"222.074001ms","start":"2026-03-31T20:14:51.911695Z","end":"2026-03-31T20:14:52.133769Z","steps":["trace[529643944] 'process raft request' (duration: 221.925285ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:52.13394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.997281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-03-31T20:14:52.134043Z","caller":"traceutil/trace.go:171","msg":"trace[2076112966] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:297; }","duration":"226.168009ms","start":"2026-03-31T20:14:51.907847Z","end":"2026-03-31T20:14:52.134015Z","steps":["trace[2076112966] 'agreement among raft nodes before linearized reading' (duration: 225.925918ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:52.170928Z","caller":"traceutil/trace.go:171","msg":"trace[1454189909] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"253.068168ms","start":"2026-03-31T20:14:51.917819Z","end":"2026-03-31T20:14:52.170887Z","steps":["trace[1454189909] 'process raft request' (duration: 252.878219ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:52.29141Z","caller":"traceutil/trace.go:171","msg":"trace[1391091091] transaction","detail":"{read_only:false; number_of_response:0; response_revision:298; }","duration":"301.772508ms","start":"2026-03-31T20:14:51.989592Z","end":"2026-03-31T20:14:52.291364Z","steps":["trace[1391091091] 'process raft request' (duration: 275.944407ms)","trace[1391091091] 'compare' (duration: 25.608461ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:14:52.29151Z","caller":"traceutil/trace.go:171","msg":"trace[336731802] linearizableReadLoop","detail":"{readStateIndex:305; appliedIndex:303; }","duration":"157.741991ms","start":"2026-03-31T20:14:52.133735Z","end":"2026-03-31T20:14:52.291477Z","steps":["trace[336731802] 'read index received' (duration: 36.940085ms)","trace[336731802] 'applied index is now lower than readState.Index' (duration: 120.800586ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:14:52.291601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:51.98956Z","time spent":"301.954386ms","remote":"127.0.0.1:32832","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-31T20:14:52.29174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.487746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-03-31T20:14:52.291793Z","caller":"traceutil/trace.go:171","msg":"trace[809608500] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:299; }","duration":"375.58881ms","start":"2026-03-31T20:14:51.916186Z","end":"2026-03-31T20:14:52.291775Z","steps":["trace[809608500] 'agreement among raft nodes before linearized reading' (duration: 375.447204ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:52.291838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:14:51.916175Z","time spent":"375.654212ms","remote":"127.0.0.1:32832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4040,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-03-31T20:14:52.292037Z","caller":"traceutil/trace.go:171","msg":"trace[272618238] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"151.792714ms","start":"2026-03-31T20:14:52.13995Z","end":"2026-03-31T20:14:52.291742Z","steps":["trace[272618238] 'process raft request' (duration: 151.328395ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:52.292285Z","caller":"traceutil/trace.go:171","msg":"trace[1944500854] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"116.841855ms","start":"2026-03-31T20:14:52.175429Z","end":"2026-03-31T20:14:52.292271Z","steps":["trace[1944500854] 'process raft request' (duration: 116.647667ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:52.292558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.049731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T20:14:52.29265Z","caller":"traceutil/trace.go:171","msg":"trace[498153040] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:0; response_revision:303; }","duration":"154.199659ms","start":"2026-03-31T20:14:52.138429Z","end":"2026-03-31T20:14:52.292628Z","steps":["trace[498153040] 'agreement among raft nodes before linearized reading' (duration: 154.042262ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:53.041929Z","caller":"traceutil/trace.go:171","msg":"trace[551345290] transaction","detail":"{read_only:false; number_of_response:0; response_revision:317; }","duration":"115.854003ms","start":"2026-03-31T20:14:52.926042Z","end":"2026-03-31T20:14:53.041896Z","steps":["trace[551345290] 'process raft request' (duration: 111.449731ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:53.115452Z","caller":"traceutil/trace.go:171","msg":"trace[1278837241] transaction","detail":"{read_only:false; number_of_response:0; response_revision:317; }","duration":"188.404708ms","start":"2026-03-31T20:14:52.927006Z","end":"2026-03-31T20:14:53.115411Z","steps":["trace[1278837241] 'process raft request' (duration: 188.160998ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:53.11562Z","caller":"traceutil/trace.go:171","msg":"trace[1232683765] transaction","detail":"{read_only:false; number_of_response:0; response_revision:317; }","duration":"188.219691ms","start":"2026-03-31T20:14:52.927364Z","end":"2026-03-31T20:14:53.115583Z","steps":["trace[1232683765] 'process raft request' (duration: 187.940259ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:53.115721Z","caller":"traceutil/trace.go:171","msg":"trace[1941316633] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"183.794948ms","start":"2026-03-31T20:14:52.931912Z","end":"2026-03-31T20:14:53.115707Z","steps":["trace[1941316633] 'process raft request' (duration: 183.442702ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:14:53.115499Z","caller":"traceutil/trace.go:171","msg":"trace[1221770372] linearizableReadLoop","detail":"{readStateIndex:330; appliedIndex:326; }","duration":"155.839224ms","start":"2026-03-31T20:14:52.959626Z","end":"2026-03-31T20:14:53.115465Z","steps":["trace[1221770372] 'read index received' (duration: 77.884495ms)","trace[1221770372] 'applied index is now lower than readState.Index' (duration: 77.953549ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:14:53.116161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.516294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-03-31T20:14:53.116578Z","caller":"traceutil/trace.go:171","msg":"trace[977552673] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:318; }","duration":"156.953703ms","start":"2026-03-31T20:14:52.959601Z","end":"2026-03-31T20:14:53.116555Z","steps":["trace[977552673] 'agreement among raft nodes before linearized reading' (duration: 156.479592ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:53.405152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.103541ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T20:14:53.405701Z","caller":"traceutil/trace.go:171","msg":"trace[396724298] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"265.562798ms","start":"2026-03-31T20:14:53.140096Z","end":"2026-03-31T20:14:53.405658Z","steps":["trace[396724298] 'process raft request' (duration: 90.83632ms)","trace[396724298] 'compare' (duration: 173.392891ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:14:53.406281Z","caller":"traceutil/trace.go:171","msg":"trace[368496320] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"245.970556ms","start":"2026-03-31T20:14:53.160167Z","end":"2026-03-31T20:14:53.406138Z","steps":["trace[368496320] 'process raft request' (duration: 245.903003ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:14:53.794668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.853406ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-31T20:14:53.7949Z","caller":"traceutil/trace.go:171","msg":"trace[274907687] transaction","detail":"{read_only:false; response_revision:331; number_of_response:1; }","duration":"135.907531ms","start":"2026-03-31T20:14:53.658947Z","end":"2026-03-31T20:14:53.794855Z","steps":["trace[274907687] 'process raft request' (duration: 14.714261ms)","trace[274907687] 'compare' (duration: 120.628075ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:15:19.76946Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495071085003231,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-31T20:15:20.057264Z","caller":"traceutil/trace.go:171","msg":"trace[884288200] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"793.244049ms","start":"2026-03-31T20:15:19.263986Z","end":"2026-03-31T20:15:20.05723Z","steps":["trace[884288200] 'process raft request' (duration: 792.901667ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:20.057524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:19.263961Z","time spent":"793.398179ms","remote":"127.0.0.1:60956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5162,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T20:15:20.063899Z","caller":"traceutil/trace.go:171","msg":"trace[368179104] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"776.868829ms","start":"2026-03-31T20:15:19.286976Z","end":"2026-03-31T20:15:20.063845Z","steps":["trace[368179104] 'process raft request' (duration: 776.573237ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:20.064041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:19.286947Z","time spent":"777.016349ms","remote":"127.0.0.1:60956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24220,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T20:15:20.064213Z","caller":"traceutil/trace.go:171","msg":"trace[1549315863] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:641; }","duration":"795.163689ms","start":"2026-03-31T20:15:19.269021Z","end":"2026-03-31T20:15:20.064185Z","steps":["trace[1549315863] 'read index received' (duration: 787.89883ms)","trace[1549315863] 'applied index is now lower than readState.Index' (duration: 7.264069ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:15:20.064318Z","caller":"traceutil/trace.go:171","msg":"trace[792701424] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"429.276861ms","start":"2026-03-31T20:15:19.634971Z","end":"2026-03-31T20:15:20.064248Z","steps":["trace[792701424] 'process raft request' (duration: 428.834749ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:20.064736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.802791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-03-31T20:15:20.064801Z","caller":"traceutil/trace.go:171","msg":"trace[175671626] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:624; }","duration":"777.953073ms","start":"2026-03-31T20:15:19.286817Z","end":"2026-03-31T20:15:20.06477Z","steps":["trace[175671626] 'agreement among raft nodes before linearized reading' (duration: 777.824832ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:20.064839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:19.286792Z","time spent":"778.038953ms","remote":"127.0.0.1:32918","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":"warn","ts":"2026-03-31T20:15:20.065076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.927915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.210\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-03-31T20:15:20.065198Z","caller":"traceutil/trace.go:171","msg":"trace[2068287988] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"229.763588ms","start":"2026-03-31T20:15:19.83537Z","end":"2026-03-31T20:15:20.065134Z","steps":["trace[2068287988] 'process raft request' (duration: 228.731583ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:20.064742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:19.634918Z","time spent":"429.738121ms","remote":"127.0.0.1:60956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-31T20:15:20.065348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.892948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T20:15:20.065489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.448361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-03-31T20:15:20.065553Z","caller":"traceutil/trace.go:171","msg":"trace[1390109806] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:624; }","duration":"777.537802ms","start":"2026-03-31T20:15:19.287998Z","end":"2026-03-31T20:15:20.065536Z","steps":["trace[1390109806] 'agreement among raft nodes before linearized reading' (duration: 777.391441ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:15:20.065212Z","caller":"traceutil/trace.go:171","msg":"trace[186685268] range","detail":"{range_begin:/registry/masterleases/199.204.45.210; range_end:; response_count:1; response_revision:624; }","duration":"400.227835ms","start":"2026-03-31T20:15:19.664961Z","end":"2026-03-31T20:15:20.065188Z","steps":["trace[186685268] 'agreement among raft nodes before linearized reading' (duration: 399.947765ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:20.065605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:19.287989Z","time spent":"777.597902ms","remote":"127.0.0.1:32918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-03-31T20:15:20.065518Z","caller":"traceutil/trace.go:171","msg":"trace[506833684] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:624; }","duration":"294.103648ms","start":"2026-03-31T20:15:19.771396Z","end":"2026-03-31T20:15:20.0655Z","steps":["trace[506833684] 'agreement among raft nodes before linearized reading' (duration: 293.902837ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:15:20.064572Z","caller":"traceutil/trace.go:171","msg":"trace[626224424] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"629.320845ms","start":"2026-03-31T20:15:19.435128Z","end":"2026-03-31T20:15:20.064448Z","steps":["trace[626224424] 'process raft request' (duration: 628.546103ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:20.065819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:19.435083Z","time spent":"630.702011ms","remote":"127.0.0.1:60956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-31T20:15:20.064397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.41348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:9149"} {"level":"info","ts":"2026-03-31T20:15:20.06592Z","caller":"traceutil/trace.go:171","msg":"trace[905119140] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:624; }","duration":"796.938786ms","start":"2026-03-31T20:15:19.268966Z","end":"2026-03-31T20:15:20.065905Z","steps":["trace[905119140] 'agreement among raft nodes before linearized reading' (duration: 795.287959ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:20.065948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:19.268902Z","time spent":"797.038465ms","remote":"127.0.0.1:60956","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":9172,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io\" "} {"level":"warn","ts":"2026-03-31T20:15:20.065674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:19.664931Z","time spent":"400.706578ms","remote":"127.0.0.1:60948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.210\" "} {"level":"info","ts":"2026-03-31T20:15:22.310217Z","caller":"traceutil/trace.go:171","msg":"trace[1519285009] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:675; }","duration":"276.798576ms","start":"2026-03-31T20:15:22.033387Z","end":"2026-03-31T20:15:22.310186Z","steps":["trace[1519285009] 'read index received' (duration: 276.029991ms)","trace[1519285009] 'applied index is now lower than readState.Index' (duration: 767.535µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:15:22.310298Z","caller":"traceutil/trace.go:171","msg":"trace[995149936] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"277.382637ms","start":"2026-03-31T20:15:22.032891Z","end":"2026-03-31T20:15:22.310273Z","steps":["trace[995149936] 'process raft request' (duration: 276.790175ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:22.310522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.097576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-03-31T20:15:22.310572Z","caller":"traceutil/trace.go:171","msg":"trace[1211598894] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:652; }","duration":"277.203907ms","start":"2026-03-31T20:15:22.033355Z","end":"2026-03-31T20:15:22.310559Z","steps":["trace[1211598894] 'agreement among raft nodes before linearized reading' (duration: 276.979136ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:15:22.413845Z","caller":"traceutil/trace.go:171","msg":"trace[1798086644] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"331.335156ms","start":"2026-03-31T20:15:22.082478Z","end":"2026-03-31T20:15:22.413813Z","steps":["trace[1798086644] 'process raft request' (duration: 313.359496ms)","trace[1798086644] 'compare' (duration: 17.757839ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:15:22.414041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:22.082438Z","time spent":"331.500436ms","remote":"127.0.0.1:60956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188237,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T20:15:22.414229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.722202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"warn","ts":"2026-03-31T20:15:22.414357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.837188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-03-31T20:15:22.414351Z","caller":"traceutil/trace.go:171","msg":"trace[522397327] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:653; }","duration":"181.888124ms","start":"2026-03-31T20:15:22.232424Z","end":"2026-03-31T20:15:22.414312Z","steps":["trace[522397327] 'agreement among raft nodes before linearized reading' (duration: 181.489342ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:15:22.41441Z","caller":"traceutil/trace.go:171","msg":"trace[629177522] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:653; }","duration":"325.936188ms","start":"2026-03-31T20:15:22.08846Z","end":"2026-03-31T20:15:22.414396Z","steps":["trace[629177522] 'agreement among raft nodes before linearized reading' (duration: 325.745567ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:22.414439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:22.088426Z","time spent":"326.007759ms","remote":"127.0.0.1:32918","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-03-31T20:15:22.414737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.401991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-31T20:15:22.414769Z","caller":"traceutil/trace.go:171","msg":"trace[1775226171] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:653; }","duration":"326.448742ms","start":"2026-03-31T20:15:22.088304Z","end":"2026-03-31T20:15:22.414753Z","steps":["trace[1775226171] 'agreement among raft nodes before linearized reading' (duration: 326.385501ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:22.41479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:22.088295Z","time spent":"326.490172ms","remote":"127.0.0.1:32918","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-03-31T20:15:22.414837Z","caller":"traceutil/trace.go:171","msg":"trace[1363614368] linearizableReadLoop","detail":"{readStateIndex:677; appliedIndex:676; }","duration":"103.468983ms","start":"2026-03-31T20:15:22.310308Z","end":"2026-03-31T20:15:22.413777Z","steps":["trace[1363614368] 'read index received' (duration: 85.515224ms)","trace[1363614368] 'applied index is now lower than readState.Index' (duration: 17.952769ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:15:27.016041Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495071085003471,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T20:15:27.516958Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495071085003471,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T20:15:27.750303Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.021437061s","expected-duration":"1s"} {"level":"info","ts":"2026-03-31T20:15:27.750809Z","caller":"traceutil/trace.go:171","msg":"trace[1210153457] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"1.308372897s","start":"2026-03-31T20:15:26.442399Z","end":"2026-03-31T20:15:27.750772Z","steps":["trace[1210153457] 'process raft request' (duration: 1.308188396s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:27.751026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:26.442378Z","time spent":"1.308545429s","remote":"127.0.0.1:32918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T20:15:28.163721Z","caller":"traceutil/trace.go:171","msg":"trace[855387663] linearizableReadLoop","detail":"{readStateIndex:716; appliedIndex:713; }","duration":"1.648422941s","start":"2026-03-31T20:15:26.515272Z","end":"2026-03-31T20:15:28.163695Z","steps":["trace[855387663] 'read index received' (duration: 1.235424739s)","trace[855387663] 'applied index is now lower than readState.Index' (duration: 412.997002ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:15:28.163792Z","caller":"traceutil/trace.go:171","msg":"trace[2131413396] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"1.720917037s","start":"2026-03-31T20:15:26.442831Z","end":"2026-03-31T20:15:28.163748Z","steps":["trace[2131413396] 'process raft request' (duration: 1.720653884s)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:15:28.163926Z","caller":"traceutil/trace.go:171","msg":"trace[1967480468] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"828.397114ms","start":"2026-03-31T20:15:27.335421Z","end":"2026-03-31T20:15:28.163818Z","steps":["trace[1967480468] 'process raft request' (duration: 828.226952ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:28.163983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:26.442808Z","time spent":"1.721080968s","remote":"127.0.0.1:32918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T20:15:28.163998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.642898803s","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-03-31T20:15:28.164038Z","caller":"traceutil/trace.go:171","msg":"trace[1013871703] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:691; }","duration":"1.642978465s","start":"2026-03-31T20:15:26.521049Z","end":"2026-03-31T20:15:28.164027Z","steps":["trace[1013871703] 'agreement among raft nodes before linearized reading' (duration: 1.642804673s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:28.164076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:26.521038Z","time spent":"1.643028915s","remote":"127.0.0.1:32918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-03-31T20:15:28.164138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:27.335381Z","time spent":"828.648026ms","remote":"127.0.0.1:32918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T20:15:28.164125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.648810385s","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-03-31T20:15:28.164233Z","caller":"traceutil/trace.go:171","msg":"trace[1744704350] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:691; }","duration":"1.648968996s","start":"2026-03-31T20:15:26.515238Z","end":"2026-03-31T20:15:28.164207Z","steps":["trace[1744704350] 'agreement among raft nodes before linearized reading' (duration: 1.648612314s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:28.164298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:26.515225Z","time spent":"1.649063237s","remote":"127.0.0.1:32918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-31T20:15:28.164297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.143518171s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-m8p7g\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-03-31T20:15:28.164341Z","caller":"traceutil/trace.go:171","msg":"trace[3860555] range","detail":"{range_begin:/registry/pods/kube-system/cilium-m8p7g; range_end:; response_count:1; response_revision:691; }","duration":"1.143601862s","start":"2026-03-31T20:15:27.020727Z","end":"2026-03-31T20:15:28.164329Z","steps":["trace[3860555] 'agreement among raft nodes before linearized reading' (duration: 1.143415361s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:28.16437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:27.020699Z","time spent":"1.143665143s","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-m8p7g\" "} {"level":"warn","ts":"2026-03-31T20:15:28.16449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.394014378s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T20:15:28.164775Z","caller":"traceutil/trace.go:171","msg":"trace[1656637049] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:691; }","duration":"1.39427571s","start":"2026-03-31T20:15:26.770438Z","end":"2026-03-31T20:15:28.164714Z","steps":["trace[1656637049] 'agreement among raft nodes before linearized reading' (duration: 1.393764255s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:28.16451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.2803369s","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-03-31T20:15:28.164839Z","caller":"traceutil/trace.go:171","msg":"trace[682502861] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:691; }","duration":"1.280734214s","start":"2026-03-31T20:15:26.88409Z","end":"2026-03-31T20:15:28.164824Z","steps":["trace[682502861] 'agreement among raft nodes before linearized reading' (duration: 1.280124848s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:28.164892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:26.884073Z","time spent":"1.280796344s","remote":"127.0.0.1:32918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-31T20:15:28.165045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:26.770423Z","time spent":"1.394538901s","remote":"127.0.0.1:60904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-31T20:15:28.288632Z","caller":"traceutil/trace.go:171","msg":"trace[281037630] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"116.623907ms","start":"2026-03-31T20:15:28.171969Z","end":"2026-03-31T20:15:28.288593Z","steps":["trace[281037630] 'process raft request' (duration: 101.596085ms)","trace[281037630] 'compare' (duration: 14.82041ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:15:28.289061Z","caller":"traceutil/trace.go:171","msg":"trace[386057156] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"116.956729ms","start":"2026-03-31T20:15:28.172069Z","end":"2026-03-31T20:15:28.289026Z","steps":["trace[386057156] 'process raft request' (duration: 116.475016ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:15:28.289154Z","caller":"traceutil/trace.go:171","msg":"trace[964270172] linearizableReadLoop","detail":"{readStateIndex:719; appliedIndex:716; }","duration":"115.568097ms","start":"2026-03-31T20:15:28.173556Z","end":"2026-03-31T20:15:28.289124Z","steps":["trace[964270172] 'read index received' (duration: 14.579207ms)","trace[964270172] 'applied index is now lower than readState.Index' (duration: 100.9874ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:15:28.289434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.8479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T20:15:28.289471Z","caller":"traceutil/trace.go:171","msg":"trace[1035099076] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:695; }","duration":"115.90792ms","start":"2026-03-31T20:15:28.17355Z","end":"2026-03-31T20:15:28.289458Z","steps":["trace[1035099076] 'agreement among raft nodes before linearized reading' (duration: 115.819689ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:15:28.289504Z","caller":"traceutil/trace.go:171","msg":"trace[2009821480] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"106.685035ms","start":"2026-03-31T20:15:28.182805Z","end":"2026-03-31T20:15:28.28949Z","steps":["trace[2009821480] 'process raft request' (duration: 105.999119ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:30.260557Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495071085003483,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-31T20:15:30.453901Z","caller":"traceutil/trace.go:171","msg":"trace[608780680] linearizableReadLoop","detail":"{readStateIndex:721; appliedIndex:720; }","duration":"694.269746ms","start":"2026-03-31T20:15:29.759596Z","end":"2026-03-31T20:15:30.453866Z","steps":["trace[608780680] 'read index received' (duration: 694.017704ms)","trace[608780680] 'applied index is now lower than readState.Index' (duration: 250.182µs)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:15:30.454136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.164139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T20:15:30.454193Z","caller":"traceutil/trace.go:171","msg":"trace[1714633322] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:695; }","duration":"684.30033ms","start":"2026-03-31T20:15:29.769877Z","end":"2026-03-31T20:15:30.454178Z","steps":["trace[1714633322] 'agreement among raft nodes before linearized reading' (duration: 684.180729ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:30.454187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.569229ms","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-03-31T20:15:30.454245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:29.769852Z","time spent":"684.379011ms","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-31T20:15:30.453955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:29.667213Z","time spent":"786.731192ms","remote":"127.0.0.1:60948","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-03-31T20:15:30.4544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.799874ms","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-03-31T20:15:30.454436Z","caller":"traceutil/trace.go:171","msg":"trace[616445011] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:695; }","duration":"159.879044ms","start":"2026-03-31T20:15:30.294549Z","end":"2026-03-31T20:15:30.454428Z","steps":["trace[616445011] 'agreement among raft nodes before linearized reading' (duration: 159.780804ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:30.454561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.997634ms","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-03-31T20:15:30.454634Z","caller":"traceutil/trace.go:171","msg":"trace[585807782] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:695; }","duration":"261.075555ms","start":"2026-03-31T20:15:30.193542Z","end":"2026-03-31T20:15:30.454618Z","steps":["trace[585807782] 'agreement among raft nodes before linearized reading' (duration: 260.831953ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:30.454764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.123533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-03-31T20:15:30.454819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.886375ms","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-03-31T20:15:30.454883Z","caller":"traceutil/trace.go:171","msg":"trace[1413151568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:695; }","duration":"285.318835ms","start":"2026-03-31T20:15:30.16954Z","end":"2026-03-31T20:15:30.454859Z","steps":["trace[1413151568] 'agreement among raft nodes before linearized reading' (duration: 284.968632ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:15:30.454932Z","caller":"traceutil/trace.go:171","msg":"trace[2040357703] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:695; }","duration":"160.062946ms","start":"2026-03-31T20:15:30.294842Z","end":"2026-03-31T20:15:30.454905Z","steps":["trace[2040357703] 'agreement among raft nodes before linearized reading' (duration: 159.806613ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:15:30.454286Z","caller":"traceutil/trace.go:171","msg":"trace[19260409] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:695; }","duration":"694.7284ms","start":"2026-03-31T20:15:29.759534Z","end":"2026-03-31T20:15:30.454263Z","steps":["trace[19260409] 'agreement among raft nodes before linearized reading' (duration: 694.464157ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:30.455183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:29.759508Z","time spent":"695.654288ms","remote":"127.0.0.1:32918","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":"info","ts":"2026-03-31T20:15:31.067819Z","caller":"traceutil/trace.go:171","msg":"trace[741006696] linearizableReadLoop","detail":"{readStateIndex:727; appliedIndex:721; }","duration":"296.308416ms","start":"2026-03-31T20:15:30.771487Z","end":"2026-03-31T20:15:31.067795Z","steps":["trace[741006696] 'read index received' (duration: 252.712808ms)","trace[741006696] 'applied index is now lower than readState.Index' (duration: 43.593968ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:15:31.06801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.517479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T20:15:31.068047Z","caller":"traceutil/trace.go:171","msg":"trace[1270845113] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:701; }","duration":"296.614979ms","start":"2026-03-31T20:15:30.771422Z","end":"2026-03-31T20:15:31.068037Z","steps":["trace[1270845113] 'agreement among raft nodes before linearized reading' (duration: 296.495208ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:15:31.068242Z","caller":"traceutil/trace.go:171","msg":"trace[874436092] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"606.203986ms","start":"2026-03-31T20:15:30.462027Z","end":"2026-03-31T20:15:31.068231Z","steps":["trace[874436092] 'process raft request' (duration: 605.661321ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:15:31.068132Z","caller":"traceutil/trace.go:171","msg":"trace[1183343794] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"606.731541ms","start":"2026-03-31T20:15:30.46134Z","end":"2026-03-31T20:15:31.068071Z","steps":["trace[1183343794] 'process raft request' (duration: 606.292455ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:15:31.068317Z","caller":"traceutil/trace.go:171","msg":"trace[2053926764] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"609.381044ms","start":"2026-03-31T20:15:30.458894Z","end":"2026-03-31T20:15:31.068275Z","steps":["trace[2053926764] 'process raft request' (duration: 565.281822ms)","trace[2053926764] 'compare' (duration: 43.074642ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T20:15:31.0684Z","caller":"traceutil/trace.go:171","msg":"trace[409178917] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"604.938695ms","start":"2026-03-31T20:15:30.463451Z","end":"2026-03-31T20:15:31.068389Z","steps":["trace[409178917] 'process raft request' (duration: 604.30927ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:15:31.068388Z","caller":"traceutil/trace.go:171","msg":"trace[1917614481] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"607.467477ms","start":"2026-03-31T20:15:30.4609Z","end":"2026-03-31T20:15:31.068367Z","steps":["trace[1917614481] 'process raft request' (duration: 606.625988ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:31.06845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:30.463435Z","time spent":"604.990896ms","remote":"127.0.0.1:32918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T20:15:31.068366Z","caller":"traceutil/trace.go:171","msg":"trace[499403291] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"605.078736ms","start":"2026-03-31T20:15:30.463279Z","end":"2026-03-31T20:15:31.068358Z","steps":["trace[499403291] 'process raft request' (duration: 604.44643ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:31.06852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:30.460874Z","time spent":"607.564429ms","remote":"127.0.0.1:32918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T20:15:31.068545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:30.463261Z","time spent":"605.225558ms","remote":"127.0.0.1:32918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T20:15:31.068562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:30.461304Z","time spent":"607.077504ms","remote":"127.0.0.1:32918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T20:15:31.068329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:30.462018Z","time spent":"606.253206ms","remote":"127.0.0.1:32918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T20:15:31.068692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:30.458843Z","time spent":"609.567737ms","remote":"127.0.0.1:60948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T20:15:49.163773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.398963048s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T20:15:49.163876Z","caller":"traceutil/trace.go:171","msg":"trace[1852394839] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:810; }","duration":"1.399152572s","start":"2026-03-31T20:15:47.764702Z","end":"2026-03-31T20:15:49.163854Z","steps":["trace[1852394839] 'count revisions from in-memory index tree' (duration: 1.398846326s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:49.163978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:47.764666Z","time spent":"1.399297563s","remote":"127.0.0.1:33130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-03-31T20:15:49.163981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.391897663s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T20:15:49.164133Z","caller":"traceutil/trace.go:171","msg":"trace[684138074] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:810; }","duration":"1.392086877s","start":"2026-03-31T20:15:47.772027Z","end":"2026-03-31T20:15:49.164114Z","steps":["trace[684138074] 'range keys from in-memory index tree' (duration: 1.391823191s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:49.164339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:47.772016Z","time spent":"1.392150577s","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-31T20:15:49.231469Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495071085003711,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T20:15:49.307082Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.149692886s","expected-duration":"1s"} {"level":"info","ts":"2026-03-31T20:15:49.307929Z","caller":"traceutil/trace.go:171","msg":"trace[2045449361] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"1.150657033s","start":"2026-03-31T20:15:48.15723Z","end":"2026-03-31T20:15:49.307887Z","steps":["trace[2045449361] 'process raft request' (duration: 1.150368708s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:49.308248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:48.157198Z","time spent":"1.150820455s","remote":"127.0.0.1:32888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T20:15:49.309147Z","caller":"traceutil/trace.go:171","msg":"trace[1280466489] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"732.584702ms","start":"2026-03-31T20:15:48.576546Z","end":"2026-03-31T20:15:49.309131Z","steps":["trace[1280466489] 'process raft request' (duration: 732.218876ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:49.309355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:48.576503Z","time spent":"732.717645ms","remote":"127.0.0.1:32918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T20:15:49.309508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.327738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-31T20:15:49.309603Z","caller":"traceutil/trace.go:171","msg":"trace[319279964] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:812; }","duration":"578.465459ms","start":"2026-03-31T20:15:48.731123Z","end":"2026-03-31T20:15:49.309588Z","steps":["trace[319279964] 'agreement among raft nodes before linearized reading' (duration: 578.151784ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:49.309805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T20:15:48.731108Z","time spent":"578.672042ms","remote":"127.0.0.1:33158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":95,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-03-31T20:15:49.308966Z","caller":"traceutil/trace.go:171","msg":"trace[1877658208] linearizableReadLoop","detail":"{readStateIndex:842; appliedIndex:840; }","duration":"577.769648ms","start":"2026-03-31T20:15:48.731167Z","end":"2026-03-31T20:15:49.308936Z","steps":["trace[1877658208] 'read index received' (duration: 576.170151ms)","trace[1877658208] 'applied index is now lower than readState.Index' (duration: 1.598327ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T20:15:49.310223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.256975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T20:15:49.310301Z","caller":"traceutil/trace.go:171","msg":"trace[1677020323] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:812; }","duration":"197.406858ms","start":"2026-03-31T20:15:49.112868Z","end":"2026-03-31T20:15:49.310275Z","steps":["trace[1677020323] 'agreement among raft nodes before linearized reading' (duration: 197.226004ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:49.310391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.529754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-03-31T20:15:49.310451Z","caller":"traceutil/trace.go:171","msg":"trace[1378414357] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:812; }","duration":"148.612465ms","start":"2026-03-31T20:15:49.161825Z","end":"2026-03-31T20:15:49.310437Z","steps":["trace[1378414357] 'agreement among raft nodes before linearized reading' (duration: 148.410772ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:49.310465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.229948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-03-31T20:15:49.310329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.120933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-03-31T20:15:49.310518Z","caller":"traceutil/trace.go:171","msg":"trace[817614937] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:812; }","duration":"138.276639ms","start":"2026-03-31T20:15:49.172224Z","end":"2026-03-31T20:15:49.310501Z","steps":["trace[817614937] 'agreement among raft nodes before linearized reading' (duration: 138.171697ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:49.310618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.758754ms","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-03-31T20:15:49.310621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.068015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T20:15:49.310682Z","caller":"traceutil/trace.go:171","msg":"trace[1484227395] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:812; }","duration":"145.278829ms","start":"2026-03-31T20:15:49.165391Z","end":"2026-03-31T20:15:49.310669Z","steps":["trace[1484227395] 'agreement among raft nodes before linearized reading' (duration: 145.018654ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:15:49.3107Z","caller":"traceutil/trace.go:171","msg":"trace[211793693] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:812; }","duration":"139.803305ms","start":"2026-03-31T20:15:49.170838Z","end":"2026-03-31T20:15:49.310641Z","steps":["trace[211793693] 'agreement among raft nodes before linearized reading' (duration: 139.717913ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T20:15:49.310603Z","caller":"traceutil/trace.go:171","msg":"trace[1722810436] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:812; }","duration":"142.40271ms","start":"2026-03-31T20:15:49.168163Z","end":"2026-03-31T20:15:49.310566Z","steps":["trace[1722810436] 'agreement among raft nodes before linearized reading' (duration: 141.965242ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T20:15:49.310923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.078562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-03-31T20:15:49.311004Z","caller":"traceutil/trace.go:171","msg":"trace[1901265986] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:812; }","duration":"153.191012ms","start":"2026-03-31T20:15:49.157795Z","end":"2026-03-31T20:15:49.310986Z","steps":["trace[1901265986] 'agreement among raft nodes before linearized reading' (duration: 152.564503ms)"],"step_count":1}