{"level":"warn","ts":"2026-05-20T02:10:47.570569Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-20T02:10:47.570651Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.238: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.238:2380","--initial-cluster=instance=https://199.204.45.238:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.238:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.238:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-20T02:10:47.570723Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-20T02:10:47.570736Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-05-20T02:10:47.570756Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-20T02:10:47.571464Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"]} {"level":"info","ts":"2026-05-20T02:10:47.571548Z","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.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.238:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-20T02:10:47.585086Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"12.668926ms"} {"level":"info","ts":"2026-05-20T02:10:47.77685Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d7dbc9f5893cc1f6","cluster-id":"823d1d08ab21430c"} {"level":"info","ts":"2026-05-20T02:10:47.777027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=()"} {"level":"info","ts":"2026-05-20T02:10:47.777099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 0"} {"level":"info","ts":"2026-05-20T02:10:47.777123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d7dbc9f5893cc1f6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-20T02:10:47.777148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 1"} {"level":"info","ts":"2026-05-20T02:10:47.777302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"warn","ts":"2026-05-20T02:10:47.796601Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-20T02:10:47.798081Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-20T02:10:47.799442Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-20T02:10:47.801781Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d7dbc9f5893cc1f6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-20T02:10:47.802Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-20T02:10:47.802113Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-20T02:10:47.802128Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-20T02:10:47.802137Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d7dbc9f5893cc1f6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-20T02:10:47.804066Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"info","ts":"2026-05-20T02:10:47.806743Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-20T02:10:47.806827Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-05-20T02:10:47.806862Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-05-20T02:10:47.807393Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-20T02:10:47.807353Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d7dbc9f5893cc1f6","initial-advertise-peer-urls":["https://199.204.45.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-20T02:10:47.8229Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","added-peer-id":"d7dbc9f5893cc1f6","added-peer-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-05-20T02:10:48.279796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 is starting a new election at term 1"} {"level":"info","ts":"2026-05-20T02:10:48.279898Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-20T02:10:48.279956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgPreVoteResp from d7dbc9f5893cc1f6 at term 1"} {"level":"info","ts":"2026-05-20T02:10:48.279985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became candidate at term 2"} {"level":"info","ts":"2026-05-20T02:10:48.280179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgVoteResp from d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-05-20T02:10:48.280211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became leader at term 2"} {"level":"info","ts":"2026-05-20T02:10:48.280246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d7dbc9f5893cc1f6 elected leader d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-05-20T02:10:48.287397Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d7dbc9f5893cc1f6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.238:2379]}","request-path":"/0/members/d7dbc9f5893cc1f6/attributes","cluster-id":"823d1d08ab21430c","publish-timeout":"7s"} {"level":"info","ts":"2026-05-20T02:10:48.287435Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T02:10:48.287546Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T02:10:48.287463Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T02:10:48.288827Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T02:10:48.289002Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T02:10:48.289053Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T02:10:48.291711Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-20T02:10:48.291797Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-20T02:10:48.292072Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.238:2379"} {"level":"info","ts":"2026-05-20T02:10:48.293261Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-20T02:10:53.246244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.256354ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T02:10:53.246415Z","caller":"traceutil/trace.go:171","msg":"trace[2096463131] transaction","detail":"{read_only:false; response_revision:263; number_of_response:1; }","duration":"573.006117ms","start":"2026-05-20T02:10:52.673365Z","end":"2026-05-20T02:10:53.246371Z","steps":["trace[2096463131] 'process raft request' (duration: 125.109459ms)","trace[2096463131] 'compare' (duration: 447.11544ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:10:53.246453Z","caller":"traceutil/trace.go:171","msg":"trace[854347005] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"537.840296ms","start":"2026-05-20T02:10:52.708595Z","end":"2026-05-20T02:10:53.246435Z","steps":["trace[854347005] 'process raft request' (duration: 537.780655ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:10:53.246474Z","caller":"traceutil/trace.go:171","msg":"trace[2037107200] linearizableReadLoop","detail":"{readStateIndex:269; appliedIndex:268; }","duration":"560.729035ms","start":"2026-05-20T02:10:52.685713Z","end":"2026-05-20T02:10:53.246442Z","steps":["trace[2037107200] 'read index received' (duration: 112.774046ms)","trace[2037107200] 'applied index is now lower than readState.Index' (duration: 447.952369ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:10:53.246523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:52.708578Z","time spent":"537.917948ms","remote":"127.0.0.1:36828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:10:53.246554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:52.673348Z","time spent":"573.147691ms","remote":"127.0.0.1:37086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":373,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:10:53.24666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.923389ms","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-05-20T02:10:53.246706Z","caller":"traceutil/trace.go:171","msg":"trace[2130422784] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:264; }","duration":"561.010422ms","start":"2026-05-20T02:10:52.685684Z","end":"2026-05-20T02:10:53.246695Z","steps":["trace[2130422784] 'agreement among raft nodes before linearized reading' (duration: 560.884669ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:10:53.246738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:52.685674Z","time spent":"561.056813ms","remote":"127.0.0.1:37014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-20T02:10:53.74689Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976532504834434136,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T02:10:54.172772Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.074304609s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-20T02:10:54.97573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"802.622987ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-05-20T02:10:54.976034Z","caller":"traceutil/trace.go:171","msg":"trace[1575276285] transaction","detail":"{read_only:false; number_of_response:0; response_revision:266; }","duration":"2.149934641s","start":"2026-05-20T02:10:52.826085Z","end":"2026-05-20T02:10:54.976019Z","steps":["trace[1575276285] 'process raft request' (duration: 2.14990731s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:10:54.9761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:52.826074Z","time spent":"2.150000382s","remote":"127.0.0.1:36942","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:10:54.976171Z","caller":"traceutil/trace.go:171","msg":"trace[534199118] transaction","detail":"{read_only:false; number_of_response:0; response_revision:264; }","duration":"2.171910988s","start":"2026-05-20T02:10:52.804233Z","end":"2026-05-20T02:10:54.976144Z","steps":["trace[534199118] 'process raft request' (duration: 1.368811011s)","trace[534199118] 'compare' (duration: 802.580336ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:10:54.976208Z","caller":"traceutil/trace.go:171","msg":"trace[390721480] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"2.150895182s","start":"2026-05-20T02:10:52.82528Z","end":"2026-05-20T02:10:54.976175Z","steps":["trace[390721480] 'process raft request' (duration: 2.150656757s)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:10:54.97627Z","caller":"traceutil/trace.go:171","msg":"trace[499938591] transaction","detail":"{read_only:false; number_of_response:0; response_revision:266; }","duration":"2.150897002s","start":"2026-05-20T02:10:52.825364Z","end":"2026-05-20T02:10:54.976261Z","steps":["trace[499938591] 'process raft request' (duration: 2.150603696s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:10:54.976301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:52.804209Z","time spent":"2.172038131s","remote":"127.0.0.1:36934","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:10:54.976322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:52.825341Z","time spent":"2.150962654s","remote":"127.0.0.1:36942","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:10:54.976449Z","caller":"traceutil/trace.go:171","msg":"trace[2088973335] transaction","detail":"{read_only:false; number_of_response:0; response_revision:264; }","duration":"2.153145841s","start":"2026-05-20T02:10:52.823273Z","end":"2026-05-20T02:10:54.976419Z","steps":["trace[2088973335] 'process raft request' (duration: 2.152546928s)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:10:54.976519Z","caller":"traceutil/trace.go:171","msg":"trace[393163380] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"2.152667521s","start":"2026-05-20T02:10:52.8238Z","end":"2026-05-20T02:10:54.976467Z","steps":["trace[393163380] 'process raft request' (duration: 2.152068378s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:10:54.976584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:52.823248Z","time spent":"2.153271583s","remote":"127.0.0.1:36942","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:10:54.976619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:52.823771Z","time spent":"2.152803443s","remote":"127.0.0.1:36942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:10:54.976629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:52.825258Z","time spent":"2.151021074s","remote":"127.0.0.1:36942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:10:54.977329Z","caller":"traceutil/trace.go:171","msg":"trace[701384562] linearizableReadLoop","detail":"{readStateIndex:279; appliedIndex:270; }","duration":"1.730768261s","start":"2026-05-20T02:10:53.246532Z","end":"2026-05-20T02:10:54.977301Z","steps":["trace[701384562] 'read index received' (duration: 926.525389ms)","trace[701384562] 'applied index is now lower than readState.Index' (duration: 804.242082ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:10:54.977586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.838146173s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:10:54.977671Z","caller":"traceutil/trace.go:171","msg":"trace[1603140491] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:269; }","duration":"1.838272336s","start":"2026-05-20T02:10:53.139379Z","end":"2026-05-20T02:10:54.977651Z","steps":["trace[1603140491] 'agreement among raft nodes before linearized reading' (duration: 1.838080322s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:10:54.977723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:53.139361Z","time spent":"1.838348887s","remote":"127.0.0.1:37014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-20T02:10:54.977873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.269590098s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T02:10:54.977905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.644776098s","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-05-20T02:10:54.977929Z","caller":"traceutil/trace.go:171","msg":"trace[231429360] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:269; }","duration":"2.269684511s","start":"2026-05-20T02:10:52.708227Z","end":"2026-05-20T02:10:54.977911Z","steps":["trace[231429360] 'agreement among raft nodes before linearized reading' (duration: 2.269586418s)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:10:54.977949Z","caller":"traceutil/trace.go:171","msg":"trace[1986564430] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:269; }","duration":"1.64485577s","start":"2026-05-20T02:10:53.33308Z","end":"2026-05-20T02:10:54.977936Z","steps":["trace[1986564430] 'agreement among raft nodes before linearized reading' (duration: 1.644779568s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:10:54.977977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:52.708207Z","time spent":"2.269759632s","remote":"127.0.0.1:37014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"warn","ts":"2026-05-20T02:10:54.977984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:53.333068Z","time spent":"1.644909101s","remote":"127.0.0.1:37014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-20T02:10:54.978002Z","caller":"traceutil/trace.go:171","msg":"trace[825201824] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"1.727797866s","start":"2026-05-20T02:10:53.250188Z","end":"2026-05-20T02:10:54.977985Z","steps":["trace[825201824] 'process raft request' (duration: 1.727042659s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:10:54.978098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:53.250175Z","time spent":"1.727878548s","remote":"127.0.0.1:37014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:10:54.978143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.269728311s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-05-20T02:10:54.978191Z","caller":"traceutil/trace.go:171","msg":"trace[527058966] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:269; }","duration":"2.269790412s","start":"2026-05-20T02:10:52.708386Z","end":"2026-05-20T02:10:54.978177Z","steps":["trace[527058966] 'agreement among raft nodes before linearized reading' (duration: 2.26968504s)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:10:54.978375Z","caller":"traceutil/trace.go:171","msg":"trace[679664148] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"1.727945488s","start":"2026-05-20T02:10:53.25041Z","end":"2026-05-20T02:10:54.978355Z","steps":["trace[679664148] 'process raft request' (duration: 1.726856764s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:10:54.978435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:53.250401Z","time spent":"1.72800446s","remote":"127.0.0.1:37102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":400,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:10:54.978437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:52.708376Z","time spent":"2.270041418s","remote":"127.0.0.1:37134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":688,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-05-20T02:10:54.978154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"876.383085ms","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-05-20T02:10:54.979524Z","caller":"traceutil/trace.go:171","msg":"trace[263960151] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:269; }","duration":"877.786825ms","start":"2026-05-20T02:10:54.101723Z","end":"2026-05-20T02:10:54.97951Z","steps":["trace[263960151] 'agreement among raft nodes before linearized reading' (duration: 876.399675ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:10:54.979585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:54.1017Z","time spent":"877.866196ms","remote":"127.0.0.1:37014","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-05-20T02:10:54.977399Z","caller":"traceutil/trace.go:171","msg":"trace[1881887335] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"1.728091952s","start":"2026-05-20T02:10:53.2493Z","end":"2026-05-20T02:10:54.977392Z","steps":["trace[1881887335] 'process raft request' (duration: 1.727830216s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:10:54.979849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:53.249276Z","time spent":"1.730544215s","remote":"127.0.0.1:36828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:10:56.32933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"894.288191ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T02:10:56.329435Z","caller":"traceutil/trace.go:171","msg":"trace[663810320] transaction","detail":"{read_only:false; response_revision:270; number_of_response:1; }","duration":"1.344848717s","start":"2026-05-20T02:10:54.984568Z","end":"2026-05-20T02:10:56.329417Z","steps":["trace[663810320] 'process raft request' (duration: 450.414013ms)","trace[663810320] 'compare' (duration: 894.098736ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:10:56.329489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:54.984553Z","time spent":"1.344916659s","remote":"127.0.0.1:37014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:10:56.360514Z","caller":"traceutil/trace.go:171","msg":"trace[960880272] transaction","detail":"{read_only:false; response_revision:271; number_of_response:1; }","duration":"1.37585109s","start":"2026-05-20T02:10:54.984639Z","end":"2026-05-20T02:10:56.36049Z","steps":["trace[960880272] 'process raft request' (duration: 1.375684276s)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:10:56.360756Z","caller":"traceutil/trace.go:171","msg":"trace[424413143] linearizableReadLoop","detail":"{readStateIndex:281; appliedIndex:279; }","duration":"1.376099165s","start":"2026-05-20T02:10:54.984644Z","end":"2026-05-20T02:10:56.360743Z","steps":["trace[424413143] 'read index received' (duration: 450.425134ms)","trace[424413143] 'applied index is now lower than readState.Index' (duration: 925.671801ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:10:56.360857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:54.984632Z","time spent":"1.375954432s","remote":"127.0.0.1:37014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T02:10:56.360922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.376259588s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-20T02:10:56.36091Z","caller":"traceutil/trace.go:171","msg":"trace[167627712] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"1.376667226s","start":"2026-05-20T02:10:54.984225Z","end":"2026-05-20T02:10:56.360892Z","steps":["trace[167627712] 'process raft request' (duration: 1.376221247s)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:10:56.360964Z","caller":"traceutil/trace.go:171","msg":"trace[1870945809] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:274; }","duration":"1.376327029s","start":"2026-05-20T02:10:54.984624Z","end":"2026-05-20T02:10:56.360951Z","steps":["trace[1870945809] 'agreement among raft nodes before linearized reading' (duration: 1.376199667s)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:10:56.360933Z","caller":"traceutil/trace.go:171","msg":"trace[1511058112] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"1.376038974s","start":"2026-05-20T02:10:54.984884Z","end":"2026-05-20T02:10:56.360923Z","steps":["trace[1511058112] 'process raft request' (duration: 1.375746538s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:10:56.361047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.376561614s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"warn","ts":"2026-05-20T02:10:56.36106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:54.984216Z","time spent":"1.376761829s","remote":"127.0.0.1:36828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:10:56.361078Z","caller":"traceutil/trace.go:171","msg":"trace[799445854] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:274; }","duration":"1.376597075s","start":"2026-05-20T02:10:54.984474Z","end":"2026-05-20T02:10:56.361071Z","steps":["trace[799445854] 'agreement among raft nodes before linearized reading' (duration: 1.376549954s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:10:56.361101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:54.984471Z","time spent":"1.376625535s","remote":"127.0.0.1:37134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":688,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-05-20T02:10:56.361154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:54.984869Z","time spent":"1.376178356s","remote":"127.0.0.1:36948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":164,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:10:56.360844Z","caller":"traceutil/trace.go:171","msg":"trace[1142523369] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"1.375815109s","start":"2026-05-20T02:10:54.984961Z","end":"2026-05-20T02:10:56.360776Z","steps":["trace[1142523369] 'process raft request' (duration: 1.375746717s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:10:56.361001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:54.984616Z","time spent":"1.37637785s","remote":"127.0.0.1:37014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-20T02:10:56.361363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:54.984951Z","time spent":"1.3763552s","remote":"127.0.0.1:37014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:10:56.361247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.376813829s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5897"} {"level":"info","ts":"2026-05-20T02:10:56.361464Z","caller":"traceutil/trace.go:171","msg":"trace[1084058202] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:274; }","duration":"1.377044296s","start":"2026-05-20T02:10:54.984408Z","end":"2026-05-20T02:10:56.361452Z","steps":["trace[1084058202] 'agreement among raft nodes before linearized reading' (duration: 1.376777689s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:10:56.361507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:54.984404Z","time spent":"1.377094257s","remote":"127.0.0.1:36942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":5921,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"warn","ts":"2026-05-20T02:10:56.362523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.377702288s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-05-20T02:10:56.362606Z","caller":"traceutil/trace.go:171","msg":"trace[626820409] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:275; }","duration":"1.377804311s","start":"2026-05-20T02:10:54.984784Z","end":"2026-05-20T02:10:56.362588Z","steps":["trace[626820409] 'agreement among raft nodes before linearized reading' (duration: 1.377614177s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:10:56.362652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:54.984779Z","time spent":"1.377865332s","remote":"127.0.0.1:36934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4041,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-20T02:10:56.363307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.378450255s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-05-20T02:10:56.363382Z","caller":"traceutil/trace.go:171","msg":"trace[1467951943] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:275; }","duration":"1.378555187s","start":"2026-05-20T02:10:54.984813Z","end":"2026-05-20T02:10:56.363368Z","steps":["trace[1467951943] 'agreement among raft nodes before linearized reading' (duration: 1.378295262s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:10:56.36342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:54.984805Z","time spent":"1.378600968s","remote":"127.0.0.1:36934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4041,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-20T02:10:56.363623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.376701186s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:10:56.363678Z","caller":"traceutil/trace.go:171","msg":"trace[1293543986] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:275; }","duration":"1.376779148s","start":"2026-05-20T02:10:54.986889Z","end":"2026-05-20T02:10:56.363668Z","steps":["trace[1293543986] 'agreement among raft nodes before linearized reading' (duration: 1.376699866s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:10:56.363698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:10:54.986881Z","time spent":"1.376812269s","remote":"127.0.0.1:36734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T02:10:57.194915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.906239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-20T02:10:57.195009Z","caller":"traceutil/trace.go:171","msg":"trace[2135833588] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:315; }","duration":"128.075361ms","start":"2026-05-20T02:10:57.066909Z","end":"2026-05-20T02:10:57.194985Z","steps":["trace[2135833588] 'range keys from in-memory index tree' (duration: 127.718253ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:10:57.79787Z","caller":"traceutil/trace.go:171","msg":"trace[1694172200] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"230.039289ms","start":"2026-05-20T02:10:57.567802Z","end":"2026-05-20T02:10:57.797841Z","steps":["trace[1694172200] 'process raft request' (duration: 188.739455ms)","trace[1694172200] 'compare' (duration: 41.177232ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:10:59.888087Z","caller":"traceutil/trace.go:171","msg":"trace[1599499730] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"123.861253ms","start":"2026-05-20T02:10:59.764204Z","end":"2026-05-20T02:10:59.888065Z","steps":["trace[1599499730] 'process raft request' (duration: 123.72631ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:10:59.891356Z","caller":"traceutil/trace.go:171","msg":"trace[1920477725] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"124.487986ms","start":"2026-05-20T02:10:59.766855Z","end":"2026-05-20T02:10:59.891343Z","steps":["trace[1920477725] 'process raft request' (duration: 124.426135ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:11:01.846808Z","caller":"traceutil/trace.go:171","msg":"trace[1909865276] linearizableReadLoop","detail":"{readStateIndex:390; appliedIndex:388; }","duration":"177.671752ms","start":"2026-05-20T02:11:01.669097Z","end":"2026-05-20T02:11:01.846769Z","steps":["trace[1909865276] 'read index received' (duration: 134.261507ms)","trace[1909865276] 'applied index is now lower than readState.Index' (duration: 43.409295ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:11:01.84691Z","caller":"traceutil/trace.go:171","msg":"trace[587089057] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"204.403188ms","start":"2026-05-20T02:11:01.642465Z","end":"2026-05-20T02:11:01.846868Z","steps":["trace[587089057] 'process raft request' (duration: 204.213304ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:01.846968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.965469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-20T02:11:01.846772Z","caller":"traceutil/trace.go:171","msg":"trace[366005267] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"206.153664ms","start":"2026-05-20T02:11:01.640582Z","end":"2026-05-20T02:11:01.846736Z","steps":["trace[366005267] 'process raft request' (duration: 162.765439ms)","trace[366005267] 'compare' (duration: 43.18131ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:11:01.847021Z","caller":"traceutil/trace.go:171","msg":"trace[1208796765] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:379; }","duration":"180.055281ms","start":"2026-05-20T02:11:01.666949Z","end":"2026-05-20T02:11:01.847005Z","steps":["trace[1208796765] 'agreement among raft nodes before linearized reading' (duration: 179.956149ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:01.847533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.039704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-05-20T02:11:01.847655Z","caller":"traceutil/trace.go:171","msg":"trace[1472440322] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:379; }","duration":"186.198607ms","start":"2026-05-20T02:11:01.661438Z","end":"2026-05-20T02:11:01.847637Z","steps":["trace[1472440322] 'agreement among raft nodes before linearized reading' (duration: 185.533043ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:11:01.847876Z","caller":"traceutil/trace.go:171","msg":"trace[192436238] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"170.036407ms","start":"2026-05-20T02:11:01.677825Z","end":"2026-05-20T02:11:01.847861Z","steps":["trace[192436238] 'process raft request' (duration: 169.71612ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:11:01.84792Z","caller":"traceutil/trace.go:171","msg":"trace[291133448] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"169.888624ms","start":"2026-05-20T02:11:01.678017Z","end":"2026-05-20T02:11:01.847906Z","steps":["trace[291133448] 'process raft request' (duration: 169.609258ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:02.912743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.538227ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T02:11:02.913076Z","caller":"traceutil/trace.go:171","msg":"trace[1875138911] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"177.862403ms","start":"2026-05-20T02:11:02.735009Z","end":"2026-05-20T02:11:02.912871Z","steps":["trace[1875138911] 'process raft request' (duration: 51.083322ms)","trace[1875138911] 'compare' (duration: 126.399223ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:11:02.914008Z","caller":"traceutil/trace.go:171","msg":"trace[2017054871] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"178.901595ms","start":"2026-05-20T02:11:02.73509Z","end":"2026-05-20T02:11:02.913992Z","steps":["trace[2017054871] 'process raft request' (duration: 178.817132ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:11:03.080171Z","caller":"traceutil/trace.go:171","msg":"trace[151958440] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"118.701444ms","start":"2026-05-20T02:11:02.961444Z","end":"2026-05-20T02:11:03.080145Z","steps":["trace[151958440] 'process raft request' (duration: 107.868527ms)","trace[151958440] 'compare' (duration: 10.667894ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:11:03.080369Z","caller":"traceutil/trace.go:171","msg":"trace[991231914] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"118.54308ms","start":"2026-05-20T02:11:02.961818Z","end":"2026-05-20T02:11:03.080361Z","steps":["trace[991231914] 'process raft request' (duration: 118.263555ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:11:03.080181Z","caller":"traceutil/trace.go:171","msg":"trace[79722371] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"117.033219ms","start":"2026-05-20T02:11:02.96313Z","end":"2026-05-20T02:11:03.080163Z","steps":["trace[79722371] 'process raft request' (duration: 116.991869ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:11:03.08112Z","caller":"traceutil/trace.go:171","msg":"trace[1806789987] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"104.591659ms","start":"2026-05-20T02:11:02.97649Z","end":"2026-05-20T02:11:03.081082Z","steps":["trace[1806789987] 'process raft request' (duration: 104.429256ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:11:16.589185Z","caller":"traceutil/trace.go:171","msg":"trace[451705184] linearizableReadLoop","detail":"{readStateIndex:518; appliedIndex:517; }","duration":"116.87269ms","start":"2026-05-20T02:11:16.472296Z","end":"2026-05-20T02:11:16.589169Z","steps":["trace[451705184] 'read index received' (duration: 116.712296ms)","trace[451705184] 'applied index is now lower than readState.Index' (duration: 159.854µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:11:16.589298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.986202ms","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-05-20T02:11:16.589294Z","caller":"traceutil/trace.go:171","msg":"trace[1662468572] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"120.499373ms","start":"2026-05-20T02:11:16.468699Z","end":"2026-05-20T02:11:16.589198Z","steps":["trace[1662468572] 'process raft request' (duration: 120.367431ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:11:16.589322Z","caller":"traceutil/trace.go:171","msg":"trace[1849776886] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:502; }","duration":"117.055362ms","start":"2026-05-20T02:11:16.472261Z","end":"2026-05-20T02:11:16.589316Z","steps":["trace[1849776886] 'agreement among raft nodes before linearized reading' (duration: 116.989291ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:16.589383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.42044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-20T02:11:16.589445Z","caller":"traceutil/trace.go:171","msg":"trace[902067178] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:502; }","duration":"116.526412ms","start":"2026-05-20T02:11:16.472902Z","end":"2026-05-20T02:11:16.589429Z","steps":["trace[902067178] 'agreement among raft nodes before linearized reading' (duration: 116.41948ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:16.589385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.697874ms","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-05-20T02:11:16.589533Z","caller":"traceutil/trace.go:171","msg":"trace[213995972] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:502; }","duration":"112.859278ms","start":"2026-05-20T02:11:16.476662Z","end":"2026-05-20T02:11:16.589521Z","steps":["trace[213995972] 'agreement among raft nodes before linearized reading' (duration: 112.692375ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:17.51526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.603771ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:11:17.515391Z","caller":"traceutil/trace.go:171","msg":"trace[652999491] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:506; }","duration":"228.755723ms","start":"2026-05-20T02:11:17.286617Z","end":"2026-05-20T02:11:17.515372Z","steps":["trace[652999491] 'range keys from in-memory index tree' (duration: 228.56494ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:11:17.518202Z","caller":"traceutil/trace.go:171","msg":"trace[143216527] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"378.932266ms","start":"2026-05-20T02:11:17.139251Z","end":"2026-05-20T02:11:17.518184Z","steps":["trace[143216527] 'process raft request' (duration: 378.814684ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:17.5183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:17.13923Z","time spent":"379.019897ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:11:17.524424Z","caller":"traceutil/trace.go:171","msg":"trace[116233509] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"377.772705ms","start":"2026-05-20T02:11:17.146623Z","end":"2026-05-20T02:11:17.524396Z","steps":["trace[116233509] 'process raft request' (duration: 377.57812ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:11:17.524478Z","caller":"traceutil/trace.go:171","msg":"trace[1569089821] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"369.260234ms","start":"2026-05-20T02:11:17.155189Z","end":"2026-05-20T02:11:17.524449Z","steps":["trace[1569089821] 'process raft request' (duration: 369.140281ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:11:17.524571Z","caller":"traceutil/trace.go:171","msg":"trace[201349033] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"369.236443ms","start":"2026-05-20T02:11:17.155318Z","end":"2026-05-20T02:11:17.524555Z","steps":["trace[201349033] 'process raft request' (duration: 369.069411ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:17.524576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:17.146607Z","time spent":"377.894168ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:11:17.524605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:17.155174Z","time spent":"369.368086ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:11:17.524686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:17.155313Z","time spent":"369.334155ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:11:17.524785Z","caller":"traceutil/trace.go:171","msg":"trace[1800670362] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"362.83295ms","start":"2026-05-20T02:11:17.161934Z","end":"2026-05-20T02:11:17.524767Z","steps":["trace[1800670362] 'process raft request' (duration: 362.578706ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:11:17.524683Z","caller":"traceutil/trace.go:171","msg":"trace[299720867] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"365.463596ms","start":"2026-05-20T02:11:17.159195Z","end":"2026-05-20T02:11:17.524658Z","steps":["trace[299720867] 'process raft request' (duration: 365.289723ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:17.524904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:17.161911Z","time spent":"362.958432ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:11:17.524911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:17.159177Z","time spent":"365.704091ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:11:17.524727Z","caller":"traceutil/trace.go:171","msg":"trace[1275096925] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"360.669322ms","start":"2026-05-20T02:11:17.164048Z","end":"2026-05-20T02:11:17.524717Z","steps":["trace[1275096925] 'process raft request' (duration: 360.501219ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:17.525065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:17.164042Z","time spent":"360.980237ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:11:17.524711Z","caller":"traceutil/trace.go:171","msg":"trace[540463034] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"215.719003ms","start":"2026-05-20T02:11:17.308975Z","end":"2026-05-20T02:11:17.524694Z","steps":["trace[540463034] 'process raft request' (duration: 215.660372ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:11:17.524731Z","caller":"traceutil/trace.go:171","msg":"trace[719975863] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"369.461547ms","start":"2026-05-20T02:11:17.155259Z","end":"2026-05-20T02:11:17.52472Z","steps":["trace[719975863] 'process raft request' (duration: 369.101291ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:17.525219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:17.155252Z","time spent":"369.949775ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:11:17.524747Z","caller":"traceutil/trace.go:171","msg":"trace[280825964] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"339.325174ms","start":"2026-05-20T02:11:17.185416Z","end":"2026-05-20T02:11:17.524741Z","steps":["trace[280825964] 'process raft request' (duration: 339.169931ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:17.525342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:17.185393Z","time spent":"339.911904ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:11:17.524697Z","caller":"traceutil/trace.go:171","msg":"trace[2123565511] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"377.915787ms","start":"2026-05-20T02:11:17.146748Z","end":"2026-05-20T02:11:17.524664Z","steps":["trace[2123565511] 'process raft request' (duration: 377.54931ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:17.525431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:17.146744Z","time spent":"378.64829ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:11:17.52472Z","caller":"traceutil/trace.go:171","msg":"trace[1403667820] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"368.748185ms","start":"2026-05-20T02:11:17.155965Z","end":"2026-05-20T02:11:17.524714Z","steps":["trace[1403667820] 'process raft request' (duration: 368.490271ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:17.525573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:17.155954Z","time spent":"369.583369ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:11:23.686031Z","caller":"traceutil/trace.go:171","msg":"trace[341302446] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"463.300682ms","start":"2026-05-20T02:11:23.222704Z","end":"2026-05-20T02:11:23.686005Z","steps":["trace[341302446] 'process raft request' (duration: 462.625871ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:23.686187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:23.222683Z","time spent":"463.423723ms","remote":"127.0.0.1:36844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T02:11:24.490361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.872934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:11:24.490436Z","caller":"traceutil/trace.go:171","msg":"trace[1860835088] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:614; }","duration":"500.016216ms","start":"2026-05-20T02:11:23.990399Z","end":"2026-05-20T02:11:24.490415Z","steps":["trace[1860835088] 'range keys from in-memory index tree' (duration: 499.736371ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:24.490467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:23.990376Z","time spent":"500.083618ms","remote":"127.0.0.1:36734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T02:11:24.490347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.216289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:11:24.490539Z","caller":"traceutil/trace.go:171","msg":"trace[1718579606] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:614; }","duration":"728.467102ms","start":"2026-05-20T02:11:23.76204Z","end":"2026-05-20T02:11:24.490507Z","steps":["trace[1718579606] 'range keys from in-memory index tree' (duration: 728.155038ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:24.490603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:23.762028Z","time spent":"728.561295ms","remote":"127.0.0.1:36980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-05-20T02:11:24.490598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"683.680226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-s2zgw\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-20T02:11:24.491013Z","caller":"traceutil/trace.go:171","msg":"trace[1972570641] range","detail":"{range_begin:/registry/pods/kube-system/cilium-s2zgw; range_end:; response_count:1; response_revision:614; }","duration":"683.976941ms","start":"2026-05-20T02:11:23.806899Z","end":"2026-05-20T02:11:24.490876Z","steps":["trace[1972570641] 'range keys from in-memory index tree' (duration: 683.423583ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:24.491226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:23.806871Z","time spent":"684.337758ms","remote":"127.0.0.1:36942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-s2zgw\" "} {"level":"warn","ts":"2026-05-20T02:11:25.814219Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976532504834434816,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T02:11:26.217333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.573988257s","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-05-20T02:11:26.217508Z","caller":"traceutil/trace.go:171","msg":"trace[2094203226] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:615; }","duration":"1.57414066s","start":"2026-05-20T02:11:24.643279Z","end":"2026-05-20T02:11:26.217419Z","steps":["trace[2094203226] 'range keys from in-memory index tree' (duration: 1.573733563s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:26.217626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:24.643268Z","time spent":"1.574339763s","remote":"127.0.0.1:37014","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-05-20T02:11:26.218011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.581615286s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-20T02:11:26.218058Z","caller":"traceutil/trace.go:171","msg":"trace[1178783195] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:615; }","duration":"1.581714707s","start":"2026-05-20T02:11:24.63633Z","end":"2026-05-20T02:11:26.218045Z","steps":["trace[1178783195] 'range keys from in-memory index tree' (duration: 1.580616079s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:26.218053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.580274504s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-20T02:11:26.219218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.578670806s","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-05-20T02:11:26.219321Z","caller":"traceutil/trace.go:171","msg":"trace[2087040176] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:615; }","duration":"1.579922288s","start":"2026-05-20T02:11:24.639372Z","end":"2026-05-20T02:11:26.219295Z","steps":["trace[2087040176] 'range keys from in-memory index tree' (duration: 1.578235729s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:26.219387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:24.639364Z","time spent":"1.580007769s","remote":"127.0.0.1:37014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-20T02:11:26.21943Z","caller":"traceutil/trace.go:171","msg":"trace[370059049] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:615; }","duration":"1.581667806s","start":"2026-05-20T02:11:24.637729Z","end":"2026-05-20T02:11:26.219397Z","steps":["trace[370059049] 'range keys from in-memory index tree' (duration: 1.579707144s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:26.219536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:24.63772Z","time spent":"1.581784828s","remote":"127.0.0.1:37014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-20T02:11:26.21809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:24.636309Z","time spent":"1.581773879s","remote":"127.0.0.1:37014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-20T02:11:26.315248Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976532504834434816,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T02:11:26.47051Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.581626181s","expected-duration":"1s"} {"level":"info","ts":"2026-05-20T02:11:26.471653Z","caller":"traceutil/trace.go:171","msg":"trace[208533744] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"1.585037517s","start":"2026-05-20T02:11:24.886593Z","end":"2026-05-20T02:11:26.47163Z","steps":["trace[208533744] 'process raft request' (duration: 1.584351185s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:26.471788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:24.886562Z","time spent":"1.585146679s","remote":"127.0.0.1:36844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:11:26.597993Z","caller":"traceutil/trace.go:171","msg":"trace[213554260] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"372.869789ms","start":"2026-05-20T02:11:26.225102Z","end":"2026-05-20T02:11:26.597971Z","steps":["trace[213554260] 'process raft request' (duration: 372.801738ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:11:26.597998Z","caller":"traceutil/trace.go:171","msg":"trace[734467300] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"373.688573ms","start":"2026-05-20T02:11:26.224285Z","end":"2026-05-20T02:11:26.597973Z","steps":["trace[734467300] 'process raft request' (duration: 373.48577ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:26.598123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:26.22507Z","time spent":"372.98531ms","remote":"127.0.0.1:37014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T02:11:26.598135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:26.224257Z","time spent":"373.811005ms","remote":"127.0.0.1:37014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:11:26.598436Z","caller":"traceutil/trace.go:171","msg":"trace[1386720274] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"372.440682ms","start":"2026-05-20T02:11:26.225958Z","end":"2026-05-20T02:11:26.598399Z","steps":["trace[1386720274] 'process raft request' (duration: 371.980064ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:11:26.598702Z","caller":"traceutil/trace.go:171","msg":"trace[256431942] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"372.073636ms","start":"2026-05-20T02:11:26.226552Z","end":"2026-05-20T02:11:26.598626Z","steps":["trace[256431942] 'process raft request' (duration: 371.7324ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:26.598679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:26.225944Z","time spent":"372.640435ms","remote":"127.0.0.1:37014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T02:11:26.599068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:26.226544Z","time spent":"372.30623ms","remote":"127.0.0.1:37014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:11:26.616725Z","caller":"traceutil/trace.go:171","msg":"trace[316591270] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:637; }","duration":"1.303797189s","start":"2026-05-20T02:11:25.312917Z","end":"2026-05-20T02:11:26.616714Z","steps":["trace[316591270] 'read index received' (duration: 1.157756241s)","trace[316591270] 'applied index is now lower than readState.Index' (duration: 146.040118ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:11:26.616812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.303903062s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:11:26.61684Z","caller":"traceutil/trace.go:171","msg":"trace[1927117625] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"1.303958542s","start":"2026-05-20T02:11:25.312872Z","end":"2026-05-20T02:11:26.61683Z","steps":["trace[1927117625] 'agreement among raft nodes before linearized reading' (duration: 1.303899501s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:26.61687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:25.312849Z","time spent":"1.304014773s","remote":"127.0.0.1:36734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T02:11:26.617028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.488553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:11:26.617085Z","caller":"traceutil/trace.go:171","msg":"trace[1755552781] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"626.589255ms","start":"2026-05-20T02:11:25.990483Z","end":"2026-05-20T02:11:26.617072Z","steps":["trace[1755552781] 'agreement among raft nodes before linearized reading' (duration: 626.500694ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:26.61712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:25.99046Z","time spent":"626.653016ms","remote":"127.0.0.1:36726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T02:11:28.287508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.085096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:11:28.287591Z","caller":"traceutil/trace.go:171","msg":"trace[1197542688] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:647; }","duration":"297.217769ms","start":"2026-05-20T02:11:27.990354Z","end":"2026-05-20T02:11:28.287572Z","steps":["trace[1197542688] 'range keys from in-memory index tree' (duration: 297.009265ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:11:28.291491Z","caller":"traceutil/trace.go:171","msg":"trace[129770051] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"300.911218ms","start":"2026-05-20T02:11:27.990566Z","end":"2026-05-20T02:11:28.291477Z","steps":["trace[129770051] 'process raft request' (duration: 300.810747ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:28.291624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:27.99054Z","time spent":"301.01689ms","remote":"127.0.0.1:36798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:11:28.295561Z","caller":"traceutil/trace.go:171","msg":"trace[1348695289] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"104.369904ms","start":"2026-05-20T02:11:28.191168Z","end":"2026-05-20T02:11:28.295538Z","steps":["trace[1348695289] 'process raft request' (duration: 104.017139ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:11:38.827493Z","caller":"traceutil/trace.go:171","msg":"trace[108183778] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"162.696037ms","start":"2026-05-20T02:11:38.66477Z","end":"2026-05-20T02:11:38.827466Z","steps":["trace[108183778] 'process raft request' (duration: 162.545945ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:11:38.829455Z","caller":"traceutil/trace.go:171","msg":"trace[2023796929] linearizableReadLoop","detail":"{readStateIndex:784; appliedIndex:781; }","duration":"162.177459ms","start":"2026-05-20T02:11:38.667245Z","end":"2026-05-20T02:11:38.829422Z","steps":["trace[2023796929] 'read index received' (duration: 160.141598ms)","trace[2023796929] 'applied index is now lower than readState.Index' (duration: 2.034881ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:11:38.829725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.466054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-20T02:11:38.829769Z","caller":"traceutil/trace.go:171","msg":"trace[2064709859] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:758; }","duration":"162.553414ms","start":"2026-05-20T02:11:38.667205Z","end":"2026-05-20T02:11:38.829758Z","steps":["trace[2064709859] 'agreement among raft nodes before linearized reading' (duration: 162.333631ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:11:38.829805Z","caller":"traceutil/trace.go:171","msg":"trace[499191596] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"164.584745ms","start":"2026-05-20T02:11:38.665187Z","end":"2026-05-20T02:11:38.829771Z","steps":["trace[499191596] 'process raft request' (duration: 164.068567ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:11:38.829835Z","caller":"traceutil/trace.go:171","msg":"trace[1104546427] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"164.374691ms","start":"2026-05-20T02:11:38.665437Z","end":"2026-05-20T02:11:38.829811Z","steps":["trace[1104546427] 'process raft request' (duration: 163.942895ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:42.180146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.247073ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T02:11:42.180375Z","caller":"traceutil/trace.go:171","msg":"trace[338533704] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"731.176387ms","start":"2026-05-20T02:11:41.449182Z","end":"2026-05-20T02:11:42.180358Z","steps":["trace[338533704] 'process raft request' (duration: 731.086245ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:42.180449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:41.449161Z","time spent":"731.254468ms","remote":"127.0.0.1:37014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:11:42.180656Z","caller":"traceutil/trace.go:171","msg":"trace[861048885] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"1.274510434s","start":"2026-05-20T02:11:40.906134Z","end":"2026-05-20T02:11:42.180644Z","steps":["trace[861048885] 'process raft request' (duration: 632.939381ms)","trace[861048885] 'compare' (duration: 639.706345ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:11:42.180713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:40.906114Z","time spent":"1.274571054s","remote":"127.0.0.1:36942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:11:42.18085Z","caller":"traceutil/trace.go:171","msg":"trace[2085514427] linearizableReadLoop","detail":"{readStateIndex:803; appliedIndex:802; }","duration":"988.97047ms","start":"2026-05-20T02:11:41.191866Z","end":"2026-05-20T02:11:42.180836Z","steps":["trace[2085514427] 'read index received' (duration: 347.140284ms)","trace[2085514427] 'applied index is now lower than readState.Index' (duration: 641.829176ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:11:42.181035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"989.175743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.238\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-20T02:11:42.181068Z","caller":"traceutil/trace.go:171","msg":"trace[230706167] range","detail":"{range_begin:/registry/masterleases/199.204.45.238; range_end:; response_count:1; response_revision:778; }","duration":"989.255585ms","start":"2026-05-20T02:11:41.191804Z","end":"2026-05-20T02:11:42.18106Z","steps":["trace[230706167] 'agreement among raft nodes before linearized reading' (duration: 989.114613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:42.181096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:41.191776Z","time spent":"989.314705ms","remote":"127.0.0.1:36768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.238\" "} {"level":"warn","ts":"2026-05-20T02:11:42.181377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.23048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-20T02:11:42.181456Z","caller":"traceutil/trace.go:171","msg":"trace[1248317301] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:778; }","duration":"316.393143ms","start":"2026-05-20T02:11:41.865044Z","end":"2026-05-20T02:11:42.181437Z","steps":["trace[1248317301] 'agreement among raft nodes before linearized reading' (duration: 316.076618ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:11:42.181504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:11:41.865019Z","time spent":"316.474424ms","remote":"127.0.0.1:37014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-20T02:11:42.181825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.134654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:11:42.182135Z","caller":"traceutil/trace.go:171","msg":"trace[638355845] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:778; }","duration":"192.49161ms","start":"2026-05-20T02:11:41.989629Z","end":"2026-05-20T02:11:42.18212Z","steps":["trace[638355845] 'agreement among raft nodes before linearized reading' (duration: 192.130464ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:12:16.247417Z","caller":"traceutil/trace.go:171","msg":"trace[1362948083] linearizableReadLoop","detail":"{readStateIndex:1073; appliedIndex:1072; }","duration":"128.396652ms","start":"2026-05-20T02:12:16.119001Z","end":"2026-05-20T02:12:16.247397Z","steps":["trace[1362948083] 'read index received' (duration: 128.253321ms)","trace[1362948083] 'applied index is now lower than readState.Index' (duration: 142.461µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:12:16.247464Z","caller":"traceutil/trace.go:171","msg":"trace[1876645151] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"200.009788ms","start":"2026-05-20T02:12:16.047422Z","end":"2026-05-20T02:12:16.247432Z","steps":["trace[1876645151] 'process raft request' (duration: 199.839276ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:12:16.247541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.530974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-95bf910e-b4d5-4f07-be5f-69952b9d71ea\" ","response":"range_response_count:1 size:3696"} {"level":"info","ts":"2026-05-20T02:12:16.247577Z","caller":"traceutil/trace.go:171","msg":"trace[1971381388] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-95bf910e-b4d5-4f07-be5f-69952b9d71ea; range_end:; response_count:1; response_revision:1038; }","duration":"128.622155ms","start":"2026-05-20T02:12:16.118943Z","end":"2026-05-20T02:12:16.247565Z","steps":["trace[1971381388] 'agreement among raft nodes before linearized reading' (duration: 128.546374ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:12:29.19837Z","caller":"traceutil/trace.go:171","msg":"trace[1092701115] linearizableReadLoop","detail":"{readStateIndex:1139; appliedIndex:1138; }","duration":"123.691471ms","start":"2026-05-20T02:12:29.074661Z","end":"2026-05-20T02:12:29.198352Z","steps":["trace[1092701115] 'read index received' (duration: 123.522858ms)","trace[1092701115] 'applied index is now lower than readState.Index' (duration: 167.853µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:12:29.198593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.913953ms","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-05-20T02:12:29.198641Z","caller":"traceutil/trace.go:171","msg":"trace[501335645] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1101; }","duration":"123.992524ms","start":"2026-05-20T02:12:29.074636Z","end":"2026-05-20T02:12:29.198629Z","steps":["trace[501335645] 'agreement among raft nodes before linearized reading' (duration: 123.863812ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:12:29.19875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.646398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2569"} {"level":"info","ts":"2026-05-20T02:12:29.198763Z","caller":"traceutil/trace.go:171","msg":"trace[1267716848] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"139.807004ms","start":"2026-05-20T02:12:29.058652Z","end":"2026-05-20T02:12:29.198459Z","steps":["trace[1267716848] 'process raft request' (duration: 139.587702ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:12:29.198846Z","caller":"traceutil/trace.go:171","msg":"trace[137042105] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1101; }","duration":"100.766069ms","start":"2026-05-20T02:12:29.098063Z","end":"2026-05-20T02:12:29.198829Z","steps":["trace[137042105] 'agreement among raft nodes before linearized reading' (duration: 100.582687ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:12:29.199079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.110624ms","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-05-20T02:12:29.19917Z","caller":"traceutil/trace.go:171","msg":"trace[1616123504] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1101; }","duration":"109.240675ms","start":"2026-05-20T02:12:29.089911Z","end":"2026-05-20T02:12:29.199152Z","steps":["trace[1616123504] 'agreement among raft nodes before linearized reading' (duration: 108.608219ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:12:29.452477Z","caller":"traceutil/trace.go:171","msg":"trace[629837703] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"248.884598ms","start":"2026-05-20T02:12:29.20357Z","end":"2026-05-20T02:12:29.452455Z","steps":["trace[629837703] 'process raft request' (duration: 248.738666ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:12:29.495757Z","caller":"traceutil/trace.go:171","msg":"trace[1715005337] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"291.504514ms","start":"2026-05-20T02:12:29.204229Z","end":"2026-05-20T02:12:29.495734Z","steps":["trace[1715005337] 'process raft request' (duration: 291.408333ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:12:29.49577Z","caller":"traceutil/trace.go:171","msg":"trace[1212631363] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"292.077781ms","start":"2026-05-20T02:12:29.203665Z","end":"2026-05-20T02:12:29.495743Z","steps":["trace[1212631363] 'process raft request' (duration: 256.529286ms)","trace[1212631363] 'compare' (duration: 35.304942ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:12:29.495848Z","caller":"traceutil/trace.go:171","msg":"trace[794972067] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"263.92677ms","start":"2026-05-20T02:12:29.231904Z","end":"2026-05-20T02:12:29.495831Z","steps":["trace[794972067] 'process raft request' (duration: 263.781178ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:12:30.006877Z","caller":"traceutil/trace.go:171","msg":"trace[1044464157] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"152.364857ms","start":"2026-05-20T02:12:29.854483Z","end":"2026-05-20T02:12:30.006848Z","steps":["trace[1044464157] 'process raft request' (duration: 152.086954ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:12:31.318899Z","caller":"traceutil/trace.go:171","msg":"trace[1276882541] linearizableReadLoop","detail":"{readStateIndex:1147; appliedIndex:1146; }","duration":"115.980763ms","start":"2026-05-20T02:12:31.202898Z","end":"2026-05-20T02:12:31.318879Z","steps":["trace[1276882541] 'read index received' (duration: 115.800881ms)","trace[1276882541] 'applied index is now lower than readState.Index' (duration: 178.572µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:12:31.319096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.179845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-20T02:12:31.319137Z","caller":"traceutil/trace.go:171","msg":"trace[1645101286] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1108; }","duration":"116.272145ms","start":"2026-05-20T02:12:31.202855Z","end":"2026-05-20T02:12:31.319127Z","steps":["trace[1645101286] 'agreement among raft nodes before linearized reading' (duration: 116.134064ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:12:31.483172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.990668ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T02:12:31.483678Z","caller":"traceutil/trace.go:171","msg":"trace[1205418301] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"160.448545ms","start":"2026-05-20T02:12:31.323208Z","end":"2026-05-20T02:12:31.483656Z","steps":["trace[1205418301] 'process raft request' (duration: 160.070931ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:12:31.483815Z","caller":"traceutil/trace.go:171","msg":"trace[1431899601] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"163.509819ms","start":"2026-05-20T02:12:31.32029Z","end":"2026-05-20T02:12:31.4838Z","steps":["trace[1431899601] 'process raft request' (duration: 26.821573ms)","trace[1431899601] 'compare' (duration: 135.883056ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:12:51.791909Z","caller":"traceutil/trace.go:171","msg":"trace[1918629205] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"112.372313ms","start":"2026-05-20T02:12:51.679509Z","end":"2026-05-20T02:12:51.791881Z","steps":["trace[1918629205] 'process raft request' (duration: 112.170261ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:13:01.318416Z","caller":"traceutil/trace.go:171","msg":"trace[148423176] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"110.351656ms","start":"2026-05-20T02:13:01.208034Z","end":"2026-05-20T02:13:01.318386Z","steps":["trace[148423176] 'process raft request' (duration: 108.975583ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:13:03.400377Z","caller":"traceutil/trace.go:171","msg":"trace[52962416] linearizableReadLoop","detail":"{readStateIndex:1265; appliedIndex:1264; }","duration":"335.306287ms","start":"2026-05-20T02:13:03.065044Z","end":"2026-05-20T02:13:03.400351Z","steps":["trace[52962416] 'read index received' (duration: 335.129525ms)","trace[52962416] 'applied index is now lower than readState.Index' (duration: 175.552µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:13:03.400522Z","caller":"traceutil/trace.go:171","msg":"trace[1492386895] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"414.734636ms","start":"2026-05-20T02:13:02.985775Z","end":"2026-05-20T02:13:03.40051Z","steps":["trace[1492386895] 'process raft request' (duration: 414.412832ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:13:03.400763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:13:02.985748Z","time spent":"414.801656ms","remote":"127.0.0.1:37014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T02:13:03.400922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.854883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/\" range_end:\"/registry/pods/kube-system0\" limit:500 ","response":"range_response_count:10 size:65275"} {"level":"info","ts":"2026-05-20T02:13:03.401022Z","caller":"traceutil/trace.go:171","msg":"trace[964294231] range","detail":"{range_begin:/registry/pods/kube-system/; range_end:/registry/pods/kube-system0; response_count:10; response_revision:1219; }","duration":"334.011175ms","start":"2026-05-20T02:13:03.066984Z","end":"2026-05-20T02:13:03.400995Z","steps":["trace[964294231] 'agreement among raft nodes before linearized reading' (duration: 333.678001ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:13:03.401006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.916923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-l4tnb\" ","response":"range_response_count:1 size:5487"} {"level":"warn","ts":"2026-05-20T02:13:03.401093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:13:03.066966Z","time spent":"334.109445ms","remote":"127.0.0.1:36942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":10,"response size":65299,"request content":"key:\"/registry/pods/kube-system/\" range_end:\"/registry/pods/kube-system0\" limit:500 "} {"level":"info","ts":"2026-05-20T02:13:03.401101Z","caller":"traceutil/trace.go:171","msg":"trace[501212128] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-l4tnb; range_end:; response_count:1; response_revision:1219; }","duration":"336.086795ms","start":"2026-05-20T02:13:03.064993Z","end":"2026-05-20T02:13:03.401079Z","steps":["trace[501212128] 'agreement among raft nodes before linearized reading' (duration: 335.769142ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:13:03.401165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:13:03.064974Z","time spent":"336.181566ms","remote":"127.0.0.1:36942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":1,"response size":5511,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-l4tnb\" "}