{"level":"warn","ts":"2026-04-20T11:57:26.742742Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T11:57:26.742844Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.153: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.153:2380","--initial-cluster=instance=https://199.204.45.153:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.153:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.153: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-04-20T11:57:26.742928Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T11:57:26.74294Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-04-20T11:57:26.742964Z","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-04-20T11:57:26.743889Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"]} {"level":"info","ts":"2026-04-20T11:57:26.744031Z","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.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.153: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-04-20T11:57:26.748044Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.620682ms"} {"level":"info","ts":"2026-04-20T11:57:26.756246Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"355195d5aae85944","cluster-id":"e424441517bc0b32"} {"level":"info","ts":"2026-04-20T11:57:26.756377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T11:57:26.756409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 0"} {"level":"info","ts":"2026-04-20T11:57:26.756434Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 355195d5aae85944 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T11:57:26.756446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 1"} {"level":"info","ts":"2026-04-20T11:57:26.756505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"warn","ts":"2026-04-20T11:57:26.761303Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T11:57:26.763411Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T11:57:26.766819Z","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-04-20T11:57:26.771288Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"355195d5aae85944","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T11:57:26.771457Z","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-04-20T11:57:26.771547Z","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-04-20T11:57:26.771566Z","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-04-20T11:57:26.771804Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"355195d5aae85944","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T11:57:26.772501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"info","ts":"2026-04-20T11:57:26.773025Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","added-peer-id":"355195d5aae85944","added-peer-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-04-20T11:57:26.777042Z","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-04-20T11:57:26.777148Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-04-20T11:57:26.777185Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-04-20T11:57:26.777488Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"355195d5aae85944","initial-advertise-peer-urls":["https://199.204.45.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T11:57:26.777564Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T11:57:27.557429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T11:57:27.557501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T11:57:27.557523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgPreVoteResp from 355195d5aae85944 at term 1"} {"level":"info","ts":"2026-04-20T11:57:27.55756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became candidate at term 2"} {"level":"info","ts":"2026-04-20T11:57:27.557571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgVoteResp from 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-04-20T11:57:27.557586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became leader at term 2"} {"level":"info","ts":"2026-04-20T11:57:27.557606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 355195d5aae85944 elected leader 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-04-20T11:57:27.558732Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T11:57:27.558729Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T11:57:27.558783Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T11:57:27.559121Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T11:57:27.559149Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T11:57:27.558689Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"355195d5aae85944","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.153:2379]}","request-path":"/0/members/355195d5aae85944/attributes","cluster-id":"e424441517bc0b32","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T11:57:27.559894Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T11:57:27.560031Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T11:57:27.560122Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T11:57:27.562948Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.153:2379"} {"level":"info","ts":"2026-04-20T11:57:27.564759Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-20T11:57:34.059515Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.811616007s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-20T11:57:34.188334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.888193ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T11:57:34.188472Z","caller":"traceutil/trace.go:171","msg":"trace[740948145] linearizableReadLoop","detail":"{readStateIndex:271; appliedIndex:269; }","duration":"1.960973848s","start":"2026-04-20T11:57:32.227451Z","end":"2026-04-20T11:57:34.188425Z","steps":["trace[740948145] 'read index received' (duration: 20.521642ms)","trace[740948145] 'applied index is now lower than readState.Index' (duration: 1.940450826s)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:57:34.188556Z","caller":"traceutil/trace.go:171","msg":"trace[301442056] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"1.965066263s","start":"2026-04-20T11:57:32.223478Z","end":"2026-04-20T11:57:34.188545Z","steps":["trace[301442056] 'process raft request' (duration: 1.836379855s)","trace[301442056] 'compare' (duration: 127.078728ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:57:34.188618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:57:32.223464Z","time spent":"1.965120753s","remote":"127.0.0.1:60524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T11:57:34.188863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.9613609s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:57:34.188924Z","caller":"traceutil/trace.go:171","msg":"trace[1538657496] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pod-garbage-collector; range_end:; response_count:0; response_revision:265; }","duration":"1.961460321s","start":"2026-04-20T11:57:32.227448Z","end":"2026-04-20T11:57:34.188909Z","steps":["trace[1538657496] 'agreement among raft nodes before linearized reading' (duration: 1.96132347s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:34.188964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:57:32.227427Z","time spent":"1.961528881s","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" "} {"level":"info","ts":"2026-04-20T11:57:34.208527Z","caller":"traceutil/trace.go:171","msg":"trace[797749788] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"1.779018682s","start":"2026-04-20T11:57:32.429471Z","end":"2026-04-20T11:57:34.208489Z","steps":["trace[797749788] 'process raft request' (duration: 1.778876461s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:34.208622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:57:32.429453Z","time spent":"1.779129222s","remote":"127.0.0.1:60346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T11:57:34.208586Z","caller":"traceutil/trace.go:171","msg":"trace[155036312] transaction","detail":"{read_only:false; number_of_response:0; response_revision:266; }","duration":"1.677060564s","start":"2026-04-20T11:57:32.531468Z","end":"2026-04-20T11:57:34.208529Z","steps":["trace[155036312] 'process raft request' (duration: 1.676960233s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:34.208718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.060978457s","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-04-20T11:57:34.208771Z","caller":"traceutil/trace.go:171","msg":"trace[1723861073] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:269; }","duration":"1.061069117s","start":"2026-04-20T11:57:33.147689Z","end":"2026-04-20T11:57:34.208758Z","steps":["trace[1723861073] 'agreement among raft nodes before linearized reading' (duration: 1.060976517s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:34.208803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:57:33.147676Z","time spent":"1.061119427s","remote":"127.0.0.1:60524","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-04-20T11:57:34.2088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:57:32.531444Z","time spent":"1.677269295s","remote":"127.0.0.1:60446","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-04-20T11:57:34.208964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.159915262s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:57:34.208972Z","caller":"traceutil/trace.go:171","msg":"trace[1880264795] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"1.652391007s","start":"2026-04-20T11:57:32.556555Z","end":"2026-04-20T11:57:34.208946Z","steps":["trace[1880264795] 'process raft request' (duration: 1.651956425s)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:34.208999Z","caller":"traceutil/trace.go:171","msg":"trace[1151960931] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:269; }","duration":"1.159980563s","start":"2026-04-20T11:57:33.04901Z","end":"2026-04-20T11:57:34.208991Z","steps":["trace[1151960931] 'agreement among raft nodes before linearized reading' (duration: 1.159930703s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:34.20903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:57:33.04899Z","time spent":"1.160034304s","remote":"127.0.0.1:60524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-20T11:57:34.209032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:57:32.556529Z","time spent":"1.652475568s","remote":"127.0.0.1:60454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T11:57:34.209151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.333703756s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:57:34.209184Z","caller":"traceutil/trace.go:171","msg":"trace[1200074958] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:269; }","duration":"1.333735256s","start":"2026-04-20T11:57:32.87544Z","end":"2026-04-20T11:57:34.209175Z","steps":["trace[1200074958] 'agreement among raft nodes before linearized reading' (duration: 1.333689276s)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:34.209139Z","caller":"traceutil/trace.go:171","msg":"trace[1716751402] transaction","detail":"{read_only:false; number_of_response:0; response_revision:266; }","duration":"1.653657814s","start":"2026-04-20T11:57:32.555432Z","end":"2026-04-20T11:57:34.20909Z","steps":["trace[1716751402] 'process raft request' (duration: 1.65303054s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:34.209245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.780027717s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:57:34.209247Z","caller":"traceutil/trace.go:171","msg":"trace[750143875] transaction","detail":"{read_only:false; number_of_response:0; response_revision:266; }","duration":"1.653408453s","start":"2026-04-20T11:57:32.555826Z","end":"2026-04-20T11:57:34.209235Z","steps":["trace[750143875] 'process raft request' (duration: 1.652655059s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:34.209312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:57:32.555801Z","time spent":"1.653479783s","remote":"127.0.0.1:60454","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-04-20T11:57:34.209376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:57:32.555413Z","time spent":"1.653844505s","remote":"127.0.0.1:60454","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-04-20T11:57:34.209209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:57:32.875362Z","time spent":"1.333841928s","remote":"127.0.0.1:60524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-20T11:57:34.209857Z","caller":"traceutil/trace.go:171","msg":"trace[44636170] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"1.652560788s","start":"2026-04-20T11:57:32.557249Z","end":"2026-04-20T11:57:34.209809Z","steps":["trace[44636170] 'process raft request' (duration: 1.65133975s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:34.209951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.863179254s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:57:34.210017Z","caller":"traceutil/trace.go:171","msg":"trace[1574882189] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:0; response_revision:269; }","duration":"1.863331755s","start":"2026-04-20T11:57:32.346665Z","end":"2026-04-20T11:57:34.209997Z","steps":["trace[1574882189] 'agreement among raft nodes before linearized reading' (duration: 1.863187334s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:34.210062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:57:32.346647Z","time spent":"1.863404325s","remote":"127.0.0.1:60736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" "} {"level":"warn","ts":"2026-04-20T11:57:34.210074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:57:32.557242Z","time spent":"1.652744519s","remote":"127.0.0.1:60454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T11:57:34.209276Z","caller":"traceutil/trace.go:171","msg":"trace[2104673458] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:269; }","duration":"1.780057697s","start":"2026-04-20T11:57:32.429212Z","end":"2026-04-20T11:57:34.209269Z","steps":["trace[2104673458] 'agreement among raft nodes before linearized reading' (duration: 1.780013987s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:34.210333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.782457653s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-04-20T11:57:34.210377Z","caller":"traceutil/trace.go:171","msg":"trace[383636787] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:269; }","duration":"1.782537173s","start":"2026-04-20T11:57:32.427829Z","end":"2026-04-20T11:57:34.210366Z","steps":["trace[383636787] 'agreement among raft nodes before linearized reading' (duration: 1.781746298s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:34.210411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:57:32.427817Z","time spent":"1.782588583s","remote":"127.0.0.1:60662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-04-20T11:57:34.210696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:57:32.429168Z","time spent":"1.781137794s","remote":"127.0.0.1:60524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"info","ts":"2026-04-20T11:57:34.211622Z","caller":"traceutil/trace.go:171","msg":"trace[869525488] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"1.652283455s","start":"2026-04-20T11:57:32.55696Z","end":"2026-04-20T11:57:34.209243Z","steps":["trace[869525488] 'process raft request' (duration: 1.651600391s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:34.215368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:57:32.55695Z","time spent":"1.657777327s","remote":"127.0.0.1:60454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T11:57:34.384525Z","caller":"traceutil/trace.go:171","msg":"trace[1205179366] transaction","detail":"{read_only:false; response_revision:276; number_of_response:1; }","duration":"139.415041ms","start":"2026-04-20T11:57:34.245072Z","end":"2026-04-20T11:57:34.384487Z","steps":["trace[1205179366] 'process raft request' (duration: 81.219678ms)","trace[1205179366] 'compare' (duration: 57.920271ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:57:34.384981Z","caller":"traceutil/trace.go:171","msg":"trace[627268745] linearizableReadLoop","detail":"{readStateIndex:285; appliedIndex:284; }","duration":"116.510126ms","start":"2026-04-20T11:57:34.267869Z","end":"2026-04-20T11:57:34.384379Z","steps":["trace[627268745] 'read index received' (duration: 58.322614ms)","trace[627268745] 'applied index is now lower than readState.Index' (duration: 58.186002ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:57:34.385034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.461481ms","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-04-20T11:57:34.385412Z","caller":"traceutil/trace.go:171","msg":"trace[1131896577] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:0; response_revision:276; }","duration":"146.871634ms","start":"2026-04-20T11:57:34.238524Z","end":"2026-04-20T11:57:34.385395Z","steps":["trace[1131896577] 'agreement among raft nodes before linearized reading' (duration: 146.447201ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:34.389694Z","caller":"traceutil/trace.go:171","msg":"trace[1168264928] transaction","detail":"{read_only:false; response_revision:277; number_of_response:1; }","duration":"117.364671ms","start":"2026-04-20T11:57:34.272308Z","end":"2026-04-20T11:57:34.389673Z","steps":["trace[1168264928] 'process raft request' (duration: 117.13806ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:34.389777Z","caller":"traceutil/trace.go:171","msg":"trace[1285851711] transaction","detail":"{read_only:false; response_revision:278; number_of_response:1; }","duration":"117.26229ms","start":"2026-04-20T11:57:34.272488Z","end":"2026-04-20T11:57:34.38975Z","steps":["trace[1285851711] 'process raft request' (duration: 117.066019ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:34.389947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.741612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-20T11:57:34.390065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.893863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-20T11:57:34.390113Z","caller":"traceutil/trace.go:171","msg":"trace[210607776] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:280; }","duration":"117.964144ms","start":"2026-04-20T11:57:34.272137Z","end":"2026-04-20T11:57:34.390101Z","steps":["trace[210607776] 'agreement among raft nodes before linearized reading' (duration: 117.878264ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:34.390122Z","caller":"traceutil/trace.go:171","msg":"trace[1862677118] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"117.40249ms","start":"2026-04-20T11:57:34.272703Z","end":"2026-04-20T11:57:34.390105Z","steps":["trace[1862677118] 'process raft request' (duration: 116.884208ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:34.390255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.71024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:57:34.390287Z","caller":"traceutil/trace.go:171","msg":"trace[300625753] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:280; }","duration":"120.75966ms","start":"2026-04-20T11:57:34.26952Z","end":"2026-04-20T11:57:34.390279Z","steps":["trace[300625753] 'agreement among raft nodes before linearized reading' (duration: 120.71455ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:34.390066Z","caller":"traceutil/trace.go:171","msg":"trace[874628156] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:280; }","duration":"117.878333ms","start":"2026-04-20T11:57:34.272166Z","end":"2026-04-20T11:57:34.390045Z","steps":["trace[874628156] 'agreement among raft nodes before linearized reading' (duration: 117.645642ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:34.390627Z","caller":"traceutil/trace.go:171","msg":"trace[107301865] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"101.403326ms","start":"2026-04-20T11:57:34.289206Z","end":"2026-04-20T11:57:34.390609Z","steps":["trace[107301865] 'process raft request' (duration: 100.431121ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:34.544469Z","caller":"traceutil/trace.go:171","msg":"trace[292415322] linearizableReadLoop","detail":"{readStateIndex:295; appliedIndex:294; }","duration":"123.645228ms","start":"2026-04-20T11:57:34.420801Z","end":"2026-04-20T11:57:34.544446Z","steps":["trace[292415322] 'read index received' (duration: 69.935102ms)","trace[292415322] 'applied index is now lower than readState.Index' (duration: 53.709206ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:57:34.544529Z","caller":"traceutil/trace.go:171","msg":"trace[34299657] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"133.323065ms","start":"2026-04-20T11:57:34.411173Z","end":"2026-04-20T11:57:34.544496Z","steps":["trace[34299657] 'process raft request' (duration: 79.561089ms)","trace[34299657] 'compare' (duration: 53.573045ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:57:34.544589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.767059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-20T11:57:34.544622Z","caller":"traceutil/trace.go:171","msg":"trace[2101486094] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:286; }","duration":"123.845379ms","start":"2026-04-20T11:57:34.420766Z","end":"2026-04-20T11:57:34.544612Z","steps":["trace[2101486094] 'agreement among raft nodes before linearized reading' (duration: 123.767548ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:34.554404Z","caller":"traceutil/trace.go:171","msg":"trace[192925913] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"132.114709ms","start":"2026-04-20T11:57:34.422276Z","end":"2026-04-20T11:57:34.554391Z","steps":["trace[192925913] 'process raft request' (duration: 131.930397ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:34.554444Z","caller":"traceutil/trace.go:171","msg":"trace[720703540] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"132.183559ms","start":"2026-04-20T11:57:34.422241Z","end":"2026-04-20T11:57:34.554425Z","steps":["trace[720703540] 'process raft request' (duration: 131.885776ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:38.683532Z","caller":"traceutil/trace.go:171","msg":"trace[2072929060] linearizableReadLoop","detail":"{readStateIndex:355; appliedIndex:354; }","duration":"144.619141ms","start":"2026-04-20T11:57:38.538893Z","end":"2026-04-20T11:57:38.683513Z","steps":["trace[2072929060] 'read index received' (duration: 97.5079ms)","trace[2072929060] 'applied index is now lower than readState.Index' (duration: 47.110511ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:57:38.68364Z","caller":"traceutil/trace.go:171","msg":"trace[1889830775] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"151.756652ms","start":"2026-04-20T11:57:38.531874Z","end":"2026-04-20T11:57:38.683631Z","steps":["trace[1889830775] 'process raft request' (duration: 104.577771ms)","trace[1889830775] 'compare' (duration: 46.957219ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:57:38.683937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.475425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4197"} {"level":"info","ts":"2026-04-20T11:57:38.684022Z","caller":"traceutil/trace.go:171","msg":"trace[560949797] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:346; }","duration":"103.617265ms","start":"2026-04-20T11:57:38.580384Z","end":"2026-04-20T11:57:38.684001Z","steps":["trace[560949797] 'agreement among raft nodes before linearized reading' (duration: 103.295774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:38.684229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.303165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-20T11:57:38.684507Z","caller":"traceutil/trace.go:171","msg":"trace[728650793] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:346; }","duration":"145.544617ms","start":"2026-04-20T11:57:38.538863Z","end":"2026-04-20T11:57:38.684407Z","steps":["trace[728650793] 'agreement among raft nodes before linearized reading' (duration: 145.134454ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:39.036268Z","caller":"traceutil/trace.go:171","msg":"trace[2108488782] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"129.03106ms","start":"2026-04-20T11:57:38.907214Z","end":"2026-04-20T11:57:39.036245Z","steps":["trace[2108488782] 'process raft request' (duration: 70.190034ms)","trace[2108488782] 'compare' (duration: 58.605175ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:57:39.036453Z","caller":"traceutil/trace.go:171","msg":"trace[213740227] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"128.984591ms","start":"2026-04-20T11:57:38.90746Z","end":"2026-04-20T11:57:39.036444Z","steps":["trace[213740227] 'process raft request' (duration: 128.689359ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:39.221909Z","caller":"traceutil/trace.go:171","msg":"trace[979120749] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"102.253514ms","start":"2026-04-20T11:57:39.119608Z","end":"2026-04-20T11:57:39.221861Z","steps":["trace[979120749] 'process raft request' (duration: 102.132644ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:39.221935Z","caller":"traceutil/trace.go:171","msg":"trace[1449744776] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"113.139917ms","start":"2026-04-20T11:57:39.108774Z","end":"2026-04-20T11:57:39.221914Z","steps":["trace[1449744776] 'process raft request' (duration: 79.635925ms)","trace[1449744776] 'compare' (duration: 33.09819ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:57:39.415651Z","caller":"traceutil/trace.go:171","msg":"trace[1638498755] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"125.984509ms","start":"2026-04-20T11:57:39.289647Z","end":"2026-04-20T11:57:39.415631Z","steps":["trace[1638498755] 'process raft request' (duration: 49.597003ms)","trace[1638498755] 'compare' (duration: 76.291316ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:57:39.464638Z","caller":"traceutil/trace.go:171","msg":"trace[2132623852] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"169.995261ms","start":"2026-04-20T11:57:39.294623Z","end":"2026-04-20T11:57:39.464618Z","steps":["trace[2132623852] 'process raft request' (duration: 169.729699ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:39.464779Z","caller":"traceutil/trace.go:171","msg":"trace[1608675978] linearizableReadLoop","detail":"{readStateIndex:382; appliedIndex:380; }","duration":"169.812829ms","start":"2026-04-20T11:57:39.294703Z","end":"2026-04-20T11:57:39.464516Z","steps":["trace[1608675978] 'read index received' (duration: 44.493364ms)","trace[1608675978] 'applied index is now lower than readState.Index' (duration: 125.318405ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:57:39.464827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.096091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-20T11:57:39.464894Z","caller":"traceutil/trace.go:171","msg":"trace[28001823] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:373; }","duration":"170.203361ms","start":"2026-04-20T11:57:39.294673Z","end":"2026-04-20T11:57:39.464876Z","steps":["trace[28001823] 'agreement among raft nodes before linearized reading' (duration: 170.06936ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:39.615576Z","caller":"traceutil/trace.go:171","msg":"trace[1747315439] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"195.581447ms","start":"2026-04-20T11:57:39.419966Z","end":"2026-04-20T11:57:39.615548Z","steps":["trace[1747315439] 'process raft request' (duration: 133.802214ms)","trace[1747315439] 'compare' (duration: 61.595612ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:57:39.615861Z","caller":"traceutil/trace.go:171","msg":"trace[371448747] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"195.882359ms","start":"2026-04-20T11:57:39.419964Z","end":"2026-04-20T11:57:39.615846Z","steps":["trace[371448747] 'process raft request' (duration: 195.540567ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:39.615912Z","caller":"traceutil/trace.go:171","msg":"trace[1026968656] linearizableReadLoop","detail":"{readStateIndex:385; appliedIndex:382; }","duration":"151.064593ms","start":"2026-04-20T11:57:39.464824Z","end":"2026-04-20T11:57:39.615889Z","steps":["trace[1026968656] 'read index received' (duration: 88.941538ms)","trace[1026968656] 'applied index is now lower than readState.Index' (duration: 62.122125ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:57:39.616121Z","caller":"traceutil/trace.go:171","msg":"trace[1304924955] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"195.530516ms","start":"2026-04-20T11:57:39.420552Z","end":"2026-04-20T11:57:39.616083Z","steps":["trace[1304924955] 'process raft request' (duration: 195.196564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:39.616269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.896146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"warn","ts":"2026-04-20T11:57:39.616388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.732016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-04-20T11:57:39.61643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.678137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4375"} {"level":"info","ts":"2026-04-20T11:57:39.616461Z","caller":"traceutil/trace.go:171","msg":"trace[1279243616] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:376; }","duration":"177.849177ms","start":"2026-04-20T11:57:39.438594Z","end":"2026-04-20T11:57:39.616443Z","steps":["trace[1279243616] 'agreement among raft nodes before linearized reading' (duration: 177.714216ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:39.616474Z","caller":"traceutil/trace.go:171","msg":"trace[1841202106] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:376; }","duration":"228.763937ms","start":"2026-04-20T11:57:39.387698Z","end":"2026-04-20T11:57:39.616461Z","steps":["trace[1841202106] 'agreement among raft nodes before linearized reading' (duration: 228.636576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:39.616363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.846122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-04-20T11:57:39.616548Z","caller":"traceutil/trace.go:171","msg":"trace[1913929750] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:376; }","duration":"277.081173ms","start":"2026-04-20T11:57:39.339449Z","end":"2026-04-20T11:57:39.61653Z","steps":["trace[1913929750] 'agreement among raft nodes before linearized reading' (duration: 276.840012ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:39.616642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.882639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3706"} {"level":"info","ts":"2026-04-20T11:57:39.616711Z","caller":"traceutil/trace.go:171","msg":"trace[917117588] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:376; }","duration":"321.962339ms","start":"2026-04-20T11:57:39.294731Z","end":"2026-04-20T11:57:39.616693Z","steps":["trace[917117588] 'agreement among raft nodes before linearized reading' (duration: 321.589707ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:39.616758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:57:39.294727Z","time spent":"322.018509ms","remote":"127.0.0.1:60736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":3729,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"info","ts":"2026-04-20T11:57:39.616624Z","caller":"traceutil/trace.go:171","msg":"trace[58919549] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:376; }","duration":"227.191439ms","start":"2026-04-20T11:57:39.389218Z","end":"2026-04-20T11:57:39.616409Z","steps":["trace[58919549] 'agreement among raft nodes before linearized reading' (duration: 226.736425ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:39.632457Z","caller":"traceutil/trace.go:171","msg":"trace[842664601] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"156.033931ms","start":"2026-04-20T11:57:39.4764Z","end":"2026-04-20T11:57:39.632434Z","steps":["trace[842664601] 'process raft request' (duration: 155.84438ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:39.632503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.407846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4375"} {"level":"info","ts":"2026-04-20T11:57:39.6329Z","caller":"traceutil/trace.go:171","msg":"trace[1472244245] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:377; }","duration":"160.843098ms","start":"2026-04-20T11:57:39.472019Z","end":"2026-04-20T11:57:39.632862Z","steps":["trace[1472244245] 'agreement among raft nodes before linearized reading' (duration: 160.415156ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:40.008355Z","caller":"traceutil/trace.go:171","msg":"trace[1782951675] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"162.989551ms","start":"2026-04-20T11:57:39.845337Z","end":"2026-04-20T11:57:40.008327Z","steps":["trace[1782951675] 'process raft request' (duration: 87.338549ms)","trace[1782951675] 'compare' (duration: 75.531071ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:57:40.017831Z","caller":"traceutil/trace.go:171","msg":"trace[856134328] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"121.353602ms","start":"2026-04-20T11:57:39.89645Z","end":"2026-04-20T11:57:40.017804Z","steps":["trace[856134328] 'process raft request' (duration: 121.249242ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:40.017876Z","caller":"traceutil/trace.go:171","msg":"trace[605124080] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"122.253029ms","start":"2026-04-20T11:57:39.895603Z","end":"2026-04-20T11:57:40.017856Z","steps":["trace[605124080] 'process raft request' (duration: 122.035228ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:40.017937Z","caller":"traceutil/trace.go:171","msg":"trace[1908784341] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"119.366352ms","start":"2026-04-20T11:57:39.898541Z","end":"2026-04-20T11:57:40.017908Z","steps":["trace[1908784341] 'process raft request' (duration: 119.179401ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:40.693257Z","caller":"traceutil/trace.go:171","msg":"trace[771063320] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"123.040139ms","start":"2026-04-20T11:57:40.570193Z","end":"2026-04-20T11:57:40.693233Z","steps":["trace[771063320] 'process raft request' (duration: 71.317035ms)","trace[771063320] 'compare' (duration: 51.555344ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:57:40.69338Z","caller":"traceutil/trace.go:171","msg":"trace[1099170399] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"123.15138ms","start":"2026-04-20T11:57:40.570198Z","end":"2026-04-20T11:57:40.693349Z","steps":["trace[1099170399] 'process raft request' (duration: 122.987719ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:40.712064Z","caller":"traceutil/trace.go:171","msg":"trace[1155910650] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"141.556135ms","start":"2026-04-20T11:57:40.570454Z","end":"2026-04-20T11:57:40.71201Z","steps":["trace[1155910650] 'process raft request' (duration: 141.190783ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:40.712802Z","caller":"traceutil/trace.go:171","msg":"trace[180713382] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"141.818367ms","start":"2026-04-20T11:57:40.570957Z","end":"2026-04-20T11:57:40.712775Z","steps":["trace[180713382] 'process raft request' (duration: 140.884112ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:40.714222Z","caller":"traceutil/trace.go:171","msg":"trace[1294958360] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"142.565969ms","start":"2026-04-20T11:57:40.571623Z","end":"2026-04-20T11:57:40.714189Z","steps":["trace[1294958360] 'process raft request' (duration: 140.91556ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:40.714986Z","caller":"traceutil/trace.go:171","msg":"trace[1234832446] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"142.819761ms","start":"2026-04-20T11:57:40.572143Z","end":"2026-04-20T11:57:40.714962Z","steps":["trace[1234832446] 'process raft request' (duration: 141.506103ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:40.715122Z","caller":"traceutil/trace.go:171","msg":"trace[639900476] linearizableReadLoop","detail":"{readStateIndex:418; appliedIndex:410; }","duration":"102.884995ms","start":"2026-04-20T11:57:40.612192Z","end":"2026-04-20T11:57:40.715077Z","steps":["trace[639900476] 'read index received' (duration: 29.401007ms)","trace[639900476] 'applied index is now lower than readState.Index' (duration: 73.480608ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:57:40.715674Z","caller":"traceutil/trace.go:171","msg":"trace[1060685348] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"142.360249ms","start":"2026-04-20T11:57:40.573281Z","end":"2026-04-20T11:57:40.715641Z","steps":["trace[1060685348] 'process raft request' (duration: 141.186033ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:40.715785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.578228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.153\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-20T11:57:40.715759Z","caller":"traceutil/trace.go:171","msg":"trace[1862840595] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"141.018361ms","start":"2026-04-20T11:57:40.570341Z","end":"2026-04-20T11:57:40.711359Z","steps":["trace[1862840595] 'process raft request' (duration: 140.80343ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:40.71585Z","caller":"traceutil/trace.go:171","msg":"trace[1029090366] range","detail":"{range_begin:/registry/masterleases/199.204.45.153; range_end:; response_count:1; response_revision:409; }","duration":"103.675549ms","start":"2026-04-20T11:57:40.612159Z","end":"2026-04-20T11:57:40.715834Z","steps":["trace[1029090366] 'agreement among raft nodes before linearized reading' (duration: 103.021575ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:40.88276Z","caller":"traceutil/trace.go:171","msg":"trace[537761413] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"102.759955ms","start":"2026-04-20T11:57:40.779952Z","end":"2026-04-20T11:57:40.882712Z","steps":["trace[537761413] 'process raft request' (duration: 102.556894ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:40.882797Z","caller":"traceutil/trace.go:171","msg":"trace[1271418046] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"119.868612ms","start":"2026-04-20T11:57:40.762893Z","end":"2026-04-20T11:57:40.882761Z","steps":["trace[1271418046] 'process raft request' (duration: 80.79492ms)","trace[1271418046] 'compare' (duration: 38.701999ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:57:41.05229Z","caller":"traceutil/trace.go:171","msg":"trace[2131603993] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"106.668205ms","start":"2026-04-20T11:57:40.945582Z","end":"2026-04-20T11:57:41.05225Z","steps":["trace[2131603993] 'process raft request' (duration: 60.468044ms)","trace[2131603993] 'compare' (duration: 45.9662ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:57:41.219897Z","caller":"traceutil/trace.go:171","msg":"trace[1933033639] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"147.665355ms","start":"2026-04-20T11:57:41.072203Z","end":"2026-04-20T11:57:41.219869Z","steps":["trace[1933033639] 'process raft request' (duration: 81.4126ms)","trace[1933033639] 'compare' (duration: 66.035444ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:57:42.770697Z","caller":"traceutil/trace.go:171","msg":"trace[1553447480] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"125.927249ms","start":"2026-04-20T11:57:42.644742Z","end":"2026-04-20T11:57:42.770669Z","steps":["trace[1553447480] 'process raft request' (duration: 59.111423ms)","trace[1553447480] 'compare' (duration: 66.535073ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:57:44.565725Z","caller":"traceutil/trace.go:171","msg":"trace[2053059637] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"156.213209ms","start":"2026-04-20T11:57:44.409477Z","end":"2026-04-20T11:57:44.56569Z","steps":["trace[2053059637] 'process raft request' (duration: 155.928478ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:44.787819Z","caller":"traceutil/trace.go:171","msg":"trace[538077008] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"136.54336ms","start":"2026-04-20T11:57:44.651257Z","end":"2026-04-20T11:57:44.7878Z","steps":["trace[538077008] 'process raft request' (duration: 136.090057ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:44.95292Z","caller":"traceutil/trace.go:171","msg":"trace[1496096215] linearizableReadLoop","detail":"{readStateIndex:460; appliedIndex:459; }","duration":"153.922767ms","start":"2026-04-20T11:57:44.798972Z","end":"2026-04-20T11:57:44.952894Z","steps":["trace[1496096215] 'read index received' (duration: 94.159083ms)","trace[1496096215] 'applied index is now lower than readState.Index' (duration: 59.762714ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:57:44.952987Z","caller":"traceutil/trace.go:171","msg":"trace[1825855633] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"154.050558ms","start":"2026-04-20T11:57:44.798903Z","end":"2026-04-20T11:57:44.952954Z","steps":["trace[1825855633] 'process raft request' (duration: 94.217294ms)","trace[1825855633] 'compare' (duration: 59.653542ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:57:44.95307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.073327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-20T11:57:44.953115Z","caller":"traceutil/trace.go:171","msg":"trace[882036488] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:449; }","duration":"154.160249ms","start":"2026-04-20T11:57:44.798942Z","end":"2026-04-20T11:57:44.953102Z","steps":["trace[882036488] 'agreement among raft nodes before linearized reading' (duration: 154.060788ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:55.766121Z","caller":"traceutil/trace.go:171","msg":"trace[372555538] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:597; }","duration":"423.410616ms","start":"2026-04-20T11:57:55.342692Z","end":"2026-04-20T11:57:55.766103Z","steps":["trace[372555538] 'read index received' (duration: 414.723006ms)","trace[372555538] 'applied index is now lower than readState.Index' (duration: 8.68694ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:57:55.766269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.560831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:65436"} {"level":"info","ts":"2026-04-20T11:57:55.766294Z","caller":"traceutil/trace.go:171","msg":"trace[841351469] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:581; }","duration":"423.625443ms","start":"2026-04-20T11:57:55.342656Z","end":"2026-04-20T11:57:55.766282Z","steps":["trace[841351469] 'agreement among raft nodes before linearized reading' (duration: 423.514439ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:57:55.766263Z","caller":"traceutil/trace.go:171","msg":"trace[1391991986] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"430.676666ms","start":"2026-04-20T11:57:55.335559Z","end":"2026-04-20T11:57:55.766236Z","steps":["trace[1391991986] 'process raft request' (duration: 421.965256ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:57:55.766324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:57:55.34264Z","time spent":"423.679435ms","remote":"127.0.0.1:60316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":65459,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-04-20T11:57:55.766405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:57:55.335538Z","time spent":"430.792409ms","remote":"127.0.0.1:60316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:58:00.78394Z","caller":"traceutil/trace.go:171","msg":"trace[1271166925] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:626; }","duration":"244.39452ms","start":"2026-04-20T11:58:00.53952Z","end":"2026-04-20T11:58:00.783914Z","steps":["trace[1271166925] 'read index received' (duration: 243.48291ms)","trace[1271166925] 'applied index is now lower than readState.Index' (duration: 910.71µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:58:00.784034Z","caller":"traceutil/trace.go:171","msg":"trace[520886667] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"298.568818ms","start":"2026-04-20T11:58:00.485425Z","end":"2026-04-20T11:58:00.783994Z","steps":["trace[520886667] 'process raft request' (duration: 297.845314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:58:00.784188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.654568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9xmrh\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-20T11:58:00.784233Z","caller":"traceutil/trace.go:171","msg":"trace[1572824800] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9xmrh; range_end:; response_count:1; response_revision:609; }","duration":"244.747122ms","start":"2026-04-20T11:58:00.539475Z","end":"2026-04-20T11:58:00.784222Z","steps":["trace[1572824800] 'agreement among raft nodes before linearized reading' (duration: 244.593867ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:58:00.784301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.795483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-20T11:58:00.784379Z","caller":"traceutil/trace.go:171","msg":"trace[618176626] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:609; }","duration":"101.893106ms","start":"2026-04-20T11:58:00.682461Z","end":"2026-04-20T11:58:00.784354Z","steps":["trace[618176626] 'agreement among raft nodes before linearized reading' (duration: 101.730981ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:58:00.784409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.229801ms","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-04-20T11:58:00.784484Z","caller":"traceutil/trace.go:171","msg":"trace[795506699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:609; }","duration":"136.354515ms","start":"2026-04-20T11:58:00.648114Z","end":"2026-04-20T11:58:00.784468Z","steps":["trace[795506699] 'agreement among raft nodes before linearized reading' (duration: 136.103317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:58:00.784903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.37948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.153\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-20T11:58:00.784975Z","caller":"traceutil/trace.go:171","msg":"trace[1138719870] range","detail":"{range_begin:/registry/masterleases/199.204.45.153; range_end:; response_count:1; response_revision:609; }","duration":"171.517055ms","start":"2026-04-20T11:58:00.613432Z","end":"2026-04-20T11:58:00.784949Z","steps":["trace[1138719870] 'agreement among raft nodes before linearized reading' (duration: 170.74147ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:58:01.370299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.971146ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-04-20T11:58:01.370438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:58:00.786014Z","time spent":"584.415302ms","remote":"127.0.0.1:60304","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-20T11:58:01.408881Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6432439524494371043,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-20T11:58:01.428509Z","caller":"traceutil/trace.go:171","msg":"trace[624467070] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"639.174056ms","start":"2026-04-20T11:58:00.789309Z","end":"2026-04-20T11:58:01.428483Z","steps":["trace[624467070] 'process raft request' (duration: 639.124994ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:58:01.428531Z","caller":"traceutil/trace.go:171","msg":"trace[1689549532] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"639.761365ms","start":"2026-04-20T11:58:00.788739Z","end":"2026-04-20T11:58:01.4285Z","steps":["trace[1689549532] 'process raft request' (duration: 639.507817ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:58:01.42866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:58:00.789289Z","time spent":"639.29459ms","remote":"127.0.0.1:60524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T11:58:01.428697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:58:00.788717Z","time spent":"639.88152ms","remote":"127.0.0.1:60524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:58:01.512397Z","caller":"traceutil/trace.go:171","msg":"trace[1836356573] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"663.292027ms","start":"2026-04-20T11:58:00.849082Z","end":"2026-04-20T11:58:01.512374Z","steps":["trace[1836356573] 'process raft request' (duration: 663.213364ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:58:01.512447Z","caller":"traceutil/trace.go:171","msg":"trace[2053915172] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"706.433496ms","start":"2026-04-20T11:58:00.805998Z","end":"2026-04-20T11:58:01.512431Z","steps":["trace[2053915172] 'process raft request' (duration: 665.869125ms)","trace[2053915172] 'compare' (duration: 40.300212ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:58:01.512545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:58:00.84906Z","time spent":"663.408141ms","remote":"127.0.0.1:60814","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T11:58:01.512557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:58:00.805975Z","time spent":"706.502708ms","remote":"127.0.0.1:60454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:58:01.512574Z","caller":"traceutil/trace.go:171","msg":"trace[2058746764] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:628; }","duration":"604.089335ms","start":"2026-04-20T11:58:00.908458Z","end":"2026-04-20T11:58:01.512548Z","steps":["trace[2058746764] 'read index received' (duration: 519.824684ms)","trace[2058746764] 'applied index is now lower than readState.Index' (duration: 84.262491ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:58:01.512639Z","caller":"traceutil/trace.go:171","msg":"trace[1850370602] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"141.091354ms","start":"2026-04-20T11:58:01.371533Z","end":"2026-04-20T11:58:01.512624Z","steps":["trace[1850370602] 'process raft request' (duration: 140.807795ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:58:01.512753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.302083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-20T11:58:01.512788Z","caller":"traceutil/trace.go:171","msg":"trace[1565147364] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:614; }","duration":"604.372595ms","start":"2026-04-20T11:58:00.908406Z","end":"2026-04-20T11:58:01.512779Z","steps":["trace[1565147364] 'agreement among raft nodes before linearized reading' (duration: 604.251341ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:58:01.512798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.266223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-04-20T11:58:01.512824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:58:00.908385Z","time spent":"604.431907ms","remote":"127.0.0.1:60524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-20T11:58:01.51283Z","caller":"traceutil/trace.go:171","msg":"trace[953073895] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:614; }","duration":"443.945875ms","start":"2026-04-20T11:58:01.068875Z","end":"2026-04-20T11:58:01.51282Z","steps":["trace[953073895] 'agreement among raft nodes before linearized reading' (duration: 443.807161ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:58:01.512856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:58:01.068851Z","time spent":"443.997847ms","remote":"127.0.0.1:60524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-20T11:58:01.512872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.271421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:58:01.512982Z","caller":"traceutil/trace.go:171","msg":"trace[370578385] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:614; }","duration":"292.513919ms","start":"2026-04-20T11:58:01.220452Z","end":"2026-04-20T11:58:01.512966Z","steps":["trace[370578385] 'agreement among raft nodes before linearized reading' (duration: 292.277321ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:58:06.705569Z","caller":"traceutil/trace.go:171","msg":"trace[715768636] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"103.112238ms","start":"2026-04-20T11:58:06.601895Z","end":"2026-04-20T11:58:06.705007Z","steps":["trace[715768636] 'process raft request' (duration: 99.475668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:58:15.537234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.732582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:58:15.537297Z","caller":"traceutil/trace.go:171","msg":"trace[1194475140] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:765; }","duration":"315.851645ms","start":"2026-04-20T11:58:15.221433Z","end":"2026-04-20T11:58:15.537285Z","steps":["trace[1194475140] 'range keys from in-memory index tree' (duration: 315.563157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:58:15.537349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:58:15.221408Z","time spent":"315.936438ms","remote":"127.0.0.1:60276","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-04-20T11:58:15.59004Z","caller":"traceutil/trace.go:171","msg":"trace[1704841321] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"173.867638ms","start":"2026-04-20T11:58:15.416146Z","end":"2026-04-20T11:58:15.590014Z","steps":["trace[1704841321] 'process raft request' (duration: 173.673663ms)"],"step_count":1}