{"level":"warn","ts":"2026-04-13T17:07:23.051876Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-13T17:07:23.051981Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.222:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.222:2380","--initial-cluster=instance=https://199.19.213.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.222:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-13T17:07:23.05207Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-13T17:07:23.052084Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.222:2380"]} {"level":"info","ts":"2026-04-13T17:07:23.052102Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-13T17:07:23.052808Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.222:2379"]} {"level":"info","ts":"2026-04-13T17:07:23.052916Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.222:2380"],"listen-peer-urls":["https://199.19.213.222:2380"],"advertise-client-urls":["https://199.19.213.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.222:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-13T17:07:23.058018Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.833397ms"} {"level":"info","ts":"2026-04-13T17:07:23.069274Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b78f8b1ca6063edc","cluster-id":"eff609df5818f5a9"} {"level":"info","ts":"2026-04-13T17:07:23.069401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b78f8b1ca6063edc switched to configuration voters=()"} {"level":"info","ts":"2026-04-13T17:07:23.069438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b78f8b1ca6063edc became follower at term 0"} {"level":"info","ts":"2026-04-13T17:07:23.069458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b78f8b1ca6063edc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-13T17:07:23.06948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b78f8b1ca6063edc became follower at term 1"} {"level":"info","ts":"2026-04-13T17:07:23.069531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b78f8b1ca6063edc switched to configuration voters=(13226943585771208412)"} {"level":"warn","ts":"2026-04-13T17:07:23.116534Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-13T17:07:23.120647Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-13T17:07:23.125652Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-13T17:07:23.132805Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b78f8b1ca6063edc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-13T17:07:23.133321Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b78f8b1ca6063edc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-13T17:07:23.133336Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-13T17:07:23.133982Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-13T17:07:23.135044Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-13T17:07:23.139419Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-13T17:07:23.140759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b78f8b1ca6063edc switched to configuration voters=(13226943585771208412)"} {"level":"info","ts":"2026-04-13T17:07:23.140893Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"eff609df5818f5a9","local-member-id":"b78f8b1ca6063edc","added-peer-id":"b78f8b1ca6063edc","added-peer-peer-urls":["https://199.19.213.222:2380"]} {"level":"info","ts":"2026-04-13T17:07:23.140987Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.222:2380"} {"level":"info","ts":"2026-04-13T17:07:23.141022Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.222:2380"} {"level":"info","ts":"2026-04-13T17:07:23.144282Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b78f8b1ca6063edc","initial-advertise-peer-urls":["https://199.19.213.222:2380"],"listen-peer-urls":["https://199.19.213.222:2380"],"advertise-client-urls":["https://199.19.213.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-13T17:07:23.144342Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-13T17:07:23.569949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b78f8b1ca6063edc is starting a new election at term 1"} {"level":"info","ts":"2026-04-13T17:07:23.570034Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b78f8b1ca6063edc became pre-candidate at term 1"} {"level":"info","ts":"2026-04-13T17:07:23.570081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b78f8b1ca6063edc received MsgPreVoteResp from b78f8b1ca6063edc at term 1"} {"level":"info","ts":"2026-04-13T17:07:23.570102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b78f8b1ca6063edc became candidate at term 2"} {"level":"info","ts":"2026-04-13T17:07:23.570109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b78f8b1ca6063edc received MsgVoteResp from b78f8b1ca6063edc at term 2"} {"level":"info","ts":"2026-04-13T17:07:23.570121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b78f8b1ca6063edc became leader at term 2"} {"level":"info","ts":"2026-04-13T17:07:23.570132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b78f8b1ca6063edc elected leader b78f8b1ca6063edc at term 2"} {"level":"info","ts":"2026-04-13T17:07:23.581679Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b78f8b1ca6063edc","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.222:2379]}","request-path":"/0/members/b78f8b1ca6063edc/attributes","cluster-id":"eff609df5818f5a9","publish-timeout":"7s"} {"level":"info","ts":"2026-04-13T17:07:23.581741Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T17:07:23.581961Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T17:07:23.58219Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T17:07:23.584573Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-13T17:07:23.58468Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-13T17:07:23.584896Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"eff609df5818f5a9","local-member-id":"b78f8b1ca6063edc","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T17:07:23.584996Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T17:07:23.585039Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T17:07:23.585234Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-13T17:07:23.585476Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.222:2379"} {"level":"info","ts":"2026-04-13T17:07:25.352513Z","caller":"traceutil/trace.go:171","msg":"trace[1602085645] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"168.562615ms","start":"2026-04-13T17:07:25.183928Z","end":"2026-04-13T17:07:25.35249Z","steps":["trace[1602085645] 'read index received' (duration: 168.46293ms)","trace[1602085645] 'applied index is now lower than readState.Index' (duration: 98.445µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:07:25.352625Z","caller":"traceutil/trace.go:171","msg":"trace[379572742] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"169.1541ms","start":"2026-04-13T17:07:25.183429Z","end":"2026-04-13T17:07:25.352583Z","steps":["trace[379572742] 'process raft request' (duration: 168.872998ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.35282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.249824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-13T17:07:25.352822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.131058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T17:07:25.352894Z","caller":"traceutil/trace.go:171","msg":"trace[236024853] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:2; }","duration":"169.358458ms","start":"2026-04-13T17:07:25.183521Z","end":"2026-04-13T17:07:25.352879Z","steps":["trace[236024853] 'agreement among raft nodes before linearized reading' (duration: 169.111358ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:25.352962Z","caller":"traceutil/trace.go:171","msg":"trace[1625076353] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:2; }","duration":"169.370028ms","start":"2026-04-13T17:07:25.183569Z","end":"2026-04-13T17:07:25.352939Z","steps":["trace[1625076353] 'agreement among raft nodes before linearized reading' (duration: 169.035004ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:25.554781Z","caller":"traceutil/trace.go:171","msg":"trace[1278276727] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"366.298463ms","start":"2026-04-13T17:07:25.188464Z","end":"2026-04-13T17:07:25.554763Z","steps":["trace[1278276727] 'process raft request' (duration: 357.953964ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:25.555033Z","caller":"traceutil/trace.go:171","msg":"trace[422972686] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"366.482841ms","start":"2026-04-13T17:07:25.188526Z","end":"2026-04-13T17:07:25.555008Z","steps":["trace[422972686] 'process raft request' (duration: 366.175458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.555162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.188445Z","time spent":"366.390886ms","remote":"127.0.0.1:37668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T17:07:25.555361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.188511Z","time spent":"366.567233ms","remote":"127.0.0.1:37668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T17:07:25.555459Z","caller":"traceutil/trace.go:171","msg":"trace[41450229] linearizableReadLoop","detail":"{readStateIndex:12; appliedIndex:5; }","duration":"202.851393ms","start":"2026-04-13T17:07:25.352596Z","end":"2026-04-13T17:07:25.555447Z","steps":["trace[41450229] 'read index received' (duration: 193.799594ms)","trace[41450229] 'applied index is now lower than readState.Index' (duration: 9.051269ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:07:25.555488Z","caller":"traceutil/trace.go:171","msg":"trace[142771228] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"366.909069ms","start":"2026-04-13T17:07:25.188534Z","end":"2026-04-13T17:07:25.555443Z","steps":["trace[142771228] 'process raft request' (duration: 366.201839ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.555606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.335586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T17:07:25.555638Z","caller":"traceutil/trace.go:171","msg":"trace[72760214] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"367.038884ms","start":"2026-04-13T17:07:25.188575Z","end":"2026-04-13T17:07:25.555614Z","steps":["trace[72760214] 'process raft request' (duration: 366.809974ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.555656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.951813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T17:07:25.555702Z","caller":"traceutil/trace.go:171","msg":"trace[1966658819] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"243.144562ms","start":"2026-04-13T17:07:25.312544Z","end":"2026-04-13T17:07:25.555689Z","steps":["trace[1966658819] 'agreement among raft nodes before linearized reading' (duration: 242.926453ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:25.555687Z","caller":"traceutil/trace.go:171","msg":"trace[1329702111] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:9; }","duration":"356.467831ms","start":"2026-04-13T17:07:25.199196Z","end":"2026-04-13T17:07:25.555664Z","steps":["trace[1329702111] 'agreement among raft nodes before linearized reading' (duration: 356.298574ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.55576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.19918Z","time spent":"356.563674ms","remote":"127.0.0.1:37524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":28,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-04-13T17:07:25.555785Z","caller":"traceutil/trace.go:171","msg":"trace[1035957163] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"295.643192ms","start":"2026-04-13T17:07:25.260115Z","end":"2026-04-13T17:07:25.555758Z","steps":["trace[1035957163] 'process raft request' (duration: 295.284577ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.555723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.188571Z","time spent":"367.116517ms","remote":"127.0.0.1:37668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T17:07:25.555892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.423643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T17:07:25.555935Z","caller":"traceutil/trace.go:171","msg":"trace[216966653] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"295.465544ms","start":"2026-04-13T17:07:25.260458Z","end":"2026-04-13T17:07:25.555923Z","steps":["trace[216966653] 'agreement among raft nodes before linearized reading' (duration: 295.404212ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:25.555934Z","caller":"traceutil/trace.go:171","msg":"trace[288593458] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"367.372328ms","start":"2026-04-13T17:07:25.188552Z","end":"2026-04-13T17:07:25.555924Z","steps":["trace[288593458] 'process raft request' (duration: 366.810355ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:25.555985Z","caller":"traceutil/trace.go:171","msg":"trace[1924533927] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"284.584268ms","start":"2026-04-13T17:07:25.271388Z","end":"2026-04-13T17:07:25.555972Z","steps":["trace[1924533927] 'process raft request' (duration: 284.035335ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.556082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.188542Z","time spent":"367.473452ms","remote":"127.0.0.1:37668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T17:07:25.555651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.188515Z","time spent":"367.059895ms","remote":"127.0.0.1:37668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T17:07:25.555537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.166517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-13T17:07:25.556311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.423118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-13T17:07:25.556011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.903726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.222\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T17:07:25.55635Z","caller":"traceutil/trace.go:171","msg":"trace[1777466340] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:9; }","duration":"372.44478ms","start":"2026-04-13T17:07:25.183898Z","end":"2026-04-13T17:07:25.556343Z","steps":["trace[1777466340] 'agreement among raft nodes before linearized reading' (duration: 371.653578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.556538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.530935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-knpf7\" ","response":"range_response_count:1 size:861"} {"level":"warn","ts":"2026-04-13T17:07:25.556558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.748134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T17:07:25.557099Z","caller":"traceutil/trace.go:171","msg":"trace[1446789823] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"149.33156ms","start":"2026-04-13T17:07:25.407757Z","end":"2026-04-13T17:07:25.557089Z","steps":["trace[1446789823] 'agreement among raft nodes before linearized reading' (duration: 148.759706ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.556403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.964603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T17:07:25.557251Z","caller":"traceutil/trace.go:171","msg":"trace[291745315] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:9; }","duration":"295.83584ms","start":"2026-04-13T17:07:25.261403Z","end":"2026-04-13T17:07:25.557238Z","steps":["trace[291745315] 'agreement among raft nodes before linearized reading' (duration: 294.975694ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:25.55627Z","caller":"traceutil/trace.go:171","msg":"trace[267668262] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:9; }","duration":"371.904768ms","start":"2026-04-13T17:07:25.184357Z","end":"2026-04-13T17:07:25.556262Z","steps":["trace[267668262] 'agreement among raft nodes before linearized reading' (duration: 371.157387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.557512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.18427Z","time spent":"373.231674ms","remote":"127.0.0.1:37380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T17:07:25.556459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.333066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T17:07:25.557703Z","caller":"traceutil/trace.go:171","msg":"trace[1526771710] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:9; }","duration":"373.587779ms","start":"2026-04-13T17:07:25.184107Z","end":"2026-04-13T17:07:25.557695Z","steps":["trace[1526771710] 'agreement among raft nodes before linearized reading' (duration: 372.331916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.557729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.184103Z","time spent":"373.617949ms","remote":"127.0.0.1:37314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" "} {"level":"warn","ts":"2026-04-13T17:07:25.556474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.388028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-04-13T17:07:25.557942Z","caller":"traceutil/trace.go:171","msg":"trace[1138248261] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:9; }","duration":"373.871601ms","start":"2026-04-13T17:07:25.184063Z","end":"2026-04-13T17:07:25.557934Z","steps":["trace[1138248261] 'agreement among raft nodes before linearized reading' (duration: 372.373629ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.558013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.184054Z","time spent":"373.904072ms","remote":"127.0.0.1:37300","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3195,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-13T17:07:25.558092Z","caller":"traceutil/trace.go:171","msg":"trace[1611177626] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-knpf7; range_end:; response_count:1; response_revision:9; }","duration":"200.714833ms","start":"2026-04-13T17:07:25.355956Z","end":"2026-04-13T17:07:25.556671Z","steps":["trace[1611177626] 'agreement among raft nodes before linearized reading' (duration: 200.510235ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.556524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.484289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T17:07:25.558198Z","caller":"traceutil/trace.go:171","msg":"trace[479541050] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"148.193202ms","start":"2026-04-13T17:07:25.409998Z","end":"2026-04-13T17:07:25.558191Z","steps":["trace[479541050] 'agreement among raft nodes before linearized reading' (duration: 146.509502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.556588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.183891Z","time spent":"372.68619ms","remote":"127.0.0.1:37180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":0,"response size":28,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"info","ts":"2026-04-13T17:07:25.556372Z","caller":"traceutil/trace.go:171","msg":"trace[1032746196] range","detail":"{range_begin:/registry/masterleases/199.19.213.222; range_end:; response_count:0; response_revision:9; }","duration":"298.289633ms","start":"2026-04-13T17:07:25.258069Z","end":"2026-04-13T17:07:25.556359Z","steps":["trace[1032746196] 'agreement among raft nodes before linearized reading' (duration: 297.915308ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.558489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.258048Z","time spent":"300.433103ms","remote":"127.0.0.1:37132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.19.213.222\" "} {"level":"warn","ts":"2026-04-13T17:07:25.92913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.207872ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-13T17:07:25.929623Z","caller":"traceutil/trace.go:171","msg":"trace[1236890193] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"368.276087ms","start":"2026-04-13T17:07:25.561316Z","end":"2026-04-13T17:07:25.929592Z","steps":["trace[1236890193] 'process raft request' (duration: 182.387345ms)","trace[1236890193] 'compare' (duration: 185.013535ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:07:25.929753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.561301Z","time spent":"368.389572ms","remote":"127.0.0.1:37224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T17:07:25.930036Z","caller":"traceutil/trace.go:171","msg":"trace[1148950773] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"367.519385ms","start":"2026-04-13T17:07:25.562493Z","end":"2026-04-13T17:07:25.930012Z","steps":["trace[1148950773] 'process raft request' (duration: 367.067036ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:25.930076Z","caller":"traceutil/trace.go:171","msg":"trace[134036722] transaction","detail":"{read_only:false; number_of_response:0; response_revision:14; }","duration":"367.331787ms","start":"2026-04-13T17:07:25.562729Z","end":"2026-04-13T17:07:25.93006Z","steps":["trace[134036722] 'process raft request' (duration: 366.905629ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:25.930152Z","caller":"traceutil/trace.go:171","msg":"trace[1436567410] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"367.341027ms","start":"2026-04-13T17:07:25.562787Z","end":"2026-04-13T17:07:25.930128Z","steps":["trace[1436567410] 'process raft request' (duration: 366.871267ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.930164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.562471Z","time spent":"367.621998ms","remote":"127.0.0.1:37668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T17:07:25.930302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.562772Z","time spent":"367.441742ms","remote":"127.0.0.1:37668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T17:07:25.930331Z","caller":"traceutil/trace.go:171","msg":"trace[24465150] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"367.647549ms","start":"2026-04-13T17:07:25.562668Z","end":"2026-04-13T17:07:25.930315Z","steps":["trace[24465150] 'process raft request' (duration: 366.93059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.930202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.562722Z","time spent":"367.39281ms","remote":"127.0.0.1:37224","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T17:07:25.93016Z","caller":"traceutil/trace.go:171","msg":"trace[777202975] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"366.718241ms","start":"2026-04-13T17:07:25.563422Z","end":"2026-04-13T17:07:25.930141Z","steps":["trace[777202975] 'process raft request' (duration: 366.285522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.930421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.562651Z","time spent":"367.720143ms","remote":"127.0.0.1:37584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T17:07:25.930507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.563404Z","time spent":"367.019634ms","remote":"127.0.0.1:37668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T17:07:25.93064Z","caller":"traceutil/trace.go:171","msg":"trace[1270693230] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"368.446383ms","start":"2026-04-13T17:07:25.561538Z","end":"2026-04-13T17:07:25.929984Z","steps":["trace[1270693230] 'process raft request' (duration: 367.945373ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:25.931114Z","caller":"traceutil/trace.go:171","msg":"trace[1017634158] linearizableReadLoop","detail":"{readStateIndex:22; appliedIndex:13; }","duration":"330.775815ms","start":"2026-04-13T17:07:25.6003Z","end":"2026-04-13T17:07:25.931076Z","steps":["trace[1017634158] 'read index received' (duration: 143.417512ms)","trace[1017634158] 'applied index is now lower than readState.Index' (duration: 187.357193ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:07:25.931142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.513567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T17:07:25.931198Z","caller":"traceutil/trace.go:171","msg":"trace[705990734] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18; }","duration":"368.594541ms","start":"2026-04-13T17:07:25.562586Z","end":"2026-04-13T17:07:25.93118Z","steps":["trace[705990734] 'agreement among raft nodes before linearized reading' (duration: 368.503687ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.931252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.562579Z","time spent":"368.662853ms","remote":"127.0.0.1:37092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T17:07:25.93132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.912834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-04-13T17:07:25.931358Z","caller":"traceutil/trace.go:171","msg":"trace[367683334] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:18; }","duration":"370.010849ms","start":"2026-04-13T17:07:25.561338Z","end":"2026-04-13T17:07:25.931349Z","steps":["trace[367683334] 'agreement among raft nodes before linearized reading' (duration: 369.895134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.931416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.561323Z","time spent":"370.084433ms","remote":"127.0.0.1:37300","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3515,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-13T17:07:25.930723Z","caller":"traceutil/trace.go:171","msg":"trace[439991561] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"366.740841ms","start":"2026-04-13T17:07:25.56397Z","end":"2026-04-13T17:07:25.930711Z","steps":["trace[439991561] 'process raft request' (duration: 365.881865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.931739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.561522Z","time spent":"369.510268ms","remote":"127.0.0.1:37668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T17:07:25.931842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.563962Z","time spent":"367.833528ms","remote":"127.0.0.1:37668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T17:07:25.930789Z","caller":"traceutil/trace.go:171","msg":"trace[900191256] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"362.589838ms","start":"2026-04-13T17:07:25.568185Z","end":"2026-04-13T17:07:25.930774Z","steps":["trace[900191256] 'process raft request' (duration: 361.803125ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.932235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.568175Z","time spent":"363.799878ms","remote":"127.0.0.1:37300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3479,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T17:07:25.932869Z","caller":"traceutil/trace.go:171","msg":"trace[595296634] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"331.327857ms","start":"2026-04-13T17:07:25.601529Z","end":"2026-04-13T17:07:25.932857Z","steps":["trace[595296634] 'process raft request' (duration: 331.223043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.932949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.601515Z","time spent":"331.395062ms","remote":"127.0.0.1:37170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T17:07:25.933246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.733585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T17:07:25.933401Z","caller":"traceutil/trace.go:171","msg":"trace[1804859978] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:19; }","duration":"169.916743ms","start":"2026-04-13T17:07:25.763471Z","end":"2026-04-13T17:07:25.933387Z","steps":["trace[1804859978] 'agreement among raft nodes before linearized reading' (duration: 169.672263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.933511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.884778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-node-lease\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T17:07:25.933574Z","caller":"traceutil/trace.go:171","msg":"trace[1130936050] range","detail":"{range_begin:/registry/namespaces/kube-node-lease; range_end:; response_count:0; response_revision:19; }","duration":"319.986083ms","start":"2026-04-13T17:07:25.613572Z","end":"2026-04-13T17:07:25.933558Z","steps":["trace[1130936050] 'agreement among raft nodes before linearized reading' (duration: 319.893489ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.933623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.613548Z","time spent":"320.064466ms","remote":"127.0.0.1:37224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-node-lease\" "} {"level":"warn","ts":"2026-04-13T17:07:25.933689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.423271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-13T17:07:25.933758Z","caller":"traceutil/trace.go:171","msg":"trace[35625741] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"315.514504ms","start":"2026-04-13T17:07:25.618232Z","end":"2026-04-13T17:07:25.933747Z","steps":["trace[35625741] 'agreement among raft nodes before linearized reading' (duration: 315.422141ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.933816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.618221Z","time spent":"315.560467ms","remote":"127.0.0.1:37224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-13T17:07:25.933841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.666776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-13T17:07:25.933886Z","caller":"traceutil/trace.go:171","msg":"trace[1654839186] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"317.743019ms","start":"2026-04-13T17:07:25.61613Z","end":"2026-04-13T17:07:25.933873Z","steps":["trace[1654839186] 'agreement among raft nodes before linearized reading' (duration: 317.661956ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:25.933938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.616115Z","time spent":"317.811201ms","remote":"127.0.0.1:37224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-13T17:07:26.268623Z","caller":"traceutil/trace.go:171","msg":"trace[604954352] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"329.765235ms","start":"2026-04-13T17:07:25.93884Z","end":"2026-04-13T17:07:26.268605Z","steps":["trace[604954352] 'process raft request' (duration: 329.602678ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:26.268809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.938834Z","time spent":"329.859248ms","remote":"127.0.0.1:37668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":956,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T17:07:26.268825Z","caller":"traceutil/trace.go:171","msg":"trace[1273923199] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"328.877286ms","start":"2026-04-13T17:07:25.939924Z","end":"2026-04-13T17:07:26.268802Z","steps":["trace[1273923199] 'process raft request' (duration: 328.583965ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:26.268854Z","caller":"traceutil/trace.go:171","msg":"trace[1109727484] linearizableReadLoop","detail":"{readStateIndex:25; appliedIndex:23; }","duration":"330.12207ms","start":"2026-04-13T17:07:25.938695Z","end":"2026-04-13T17:07:26.268817Z","steps":["trace[1109727484] 'read index received' (duration: 65.856131ms)","trace[1109727484] 'applied index is now lower than readState.Index' (duration: 264.263979ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:07:26.26901Z","caller":"traceutil/trace.go:171","msg":"trace[764504138] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"328.632697ms","start":"2026-04-13T17:07:25.940364Z","end":"2026-04-13T17:07:26.268997Z","steps":["trace[764504138] 'process raft request' (duration: 328.274542ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:26.26905Z","caller":"traceutil/trace.go:171","msg":"trace[972418257] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"328.635048ms","start":"2026-04-13T17:07:25.940402Z","end":"2026-04-13T17:07:26.269037Z","steps":["trace[972418257] 'process raft request' (duration: 328.278523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:26.269059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.940356Z","time spent":"328.679019ms","remote":"127.0.0.1:37380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T17:07:26.268986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.939891Z","time spent":"328.998192ms","remote":"127.0.0.1:37668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":947,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T17:07:26.269223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.940394Z","time spent":"328.69583ms","remote":"127.0.0.1:37668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T17:07:26.269267Z","caller":"traceutil/trace.go:171","msg":"trace[686683749] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"328.815044ms","start":"2026-04-13T17:07:25.940444Z","end":"2026-04-13T17:07:26.269259Z","steps":["trace[686683749] 'process raft request' (duration: 328.265751ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:26.271202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.940437Z","time spent":"330.722174ms","remote":"127.0.0.1:37380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T17:07:26.269301Z","caller":"traceutil/trace.go:171","msg":"trace[2117071326] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"328.21972ms","start":"2026-04-13T17:07:25.941074Z","end":"2026-04-13T17:07:26.269294Z","steps":["trace[2117071326] 'process raft request' (duration: 327.690888ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:26.271494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.941066Z","time spent":"330.350589ms","remote":"127.0.0.1:37668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T17:07:26.269364Z","caller":"traceutil/trace.go:171","msg":"trace[1785089007] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"329.295785ms","start":"2026-04-13T17:07:25.940052Z","end":"2026-04-13T17:07:26.269348Z","steps":["trace[1785089007] 'process raft request' (duration: 328.503082ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:26.271724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.940044Z","time spent":"331.59356ms","remote":"127.0.0.1:37584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T17:07:26.269408Z","caller":"traceutil/trace.go:171","msg":"trace[1527978598] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"329.128958ms","start":"2026-04-13T17:07:25.940271Z","end":"2026-04-13T17:07:26.2694Z","steps":["trace[1527978598] 'process raft request' (duration: 328.339235ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:26.271922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.94026Z","time spent":"331.628101ms","remote":"127.0.0.1:37668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T17:07:26.269512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.792817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T17:07:26.272173Z","caller":"traceutil/trace.go:171","msg":"trace[104575373] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:29; }","duration":"333.445947ms","start":"2026-04-13T17:07:25.938675Z","end":"2026-04-13T17:07:26.272121Z","steps":["trace[104575373] 'agreement among raft nodes before linearized reading' (duration: 330.671573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:26.272264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.938666Z","time spent":"333.574782ms","remote":"127.0.0.1:37196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" "} {"level":"warn","ts":"2026-04-13T17:07:26.269605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.323456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T17:07:26.272472Z","caller":"traceutil/trace.go:171","msg":"trace[1621263443] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:29; }","duration":"114.186263ms","start":"2026-04-13T17:07:26.158248Z","end":"2026-04-13T17:07:26.272434Z","steps":["trace[1621263443] 'agreement among raft nodes before linearized reading' (duration: 111.312265ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:26.269584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.568407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-13T17:07:26.26967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.727922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T17:07:26.26855Z","caller":"traceutil/trace.go:171","msg":"trace[748546354] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"331.723966ms","start":"2026-04-13T17:07:25.936784Z","end":"2026-04-13T17:07:26.268507Z","steps":["trace[748546354] 'process raft request' (duration: 285.545937ms)","trace[748546354] 'compare' (duration: 45.881476ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:07:26.273442Z","caller":"traceutil/trace.go:171","msg":"trace[1428090406] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:29; }","duration":"334.470169ms","start":"2026-04-13T17:07:25.938954Z","end":"2026-04-13T17:07:26.273424Z","steps":["trace[1428090406] 'agreement among raft nodes before linearized reading' (duration: 330.412902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:26.273494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.93895Z","time spent":"334.530552ms","remote":"127.0.0.1:37214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":28,"request content":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" "} {"level":"info","ts":"2026-04-13T17:07:26.273893Z","caller":"traceutil/trace.go:171","msg":"trace[1996888023] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:29; }","duration":"115.984159ms","start":"2026-04-13T17:07:26.157897Z","end":"2026-04-13T17:07:26.273881Z","steps":["trace[1996888023] 'agreement among raft nodes before linearized reading' (duration: 111.725982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:26.273974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:25.936776Z","time spent":"336.477365ms","remote":"127.0.0.1:37524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T17:07:26.393775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.705937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-13T17:07:26.393867Z","caller":"traceutil/trace.go:171","msg":"trace[506906020] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:40; }","duration":"115.812231ms","start":"2026-04-13T17:07:26.278027Z","end":"2026-04-13T17:07:26.393839Z","steps":["trace[506906020] 'agreement among raft nodes before linearized reading' (duration: 115.612074ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:27.015114Z","caller":"traceutil/trace.go:171","msg":"trace[841236808] transaction","detail":"{read_only:false; response_revision:86; number_of_response:1; }","duration":"120.161768ms","start":"2026-04-13T17:07:26.894926Z","end":"2026-04-13T17:07:27.015087Z","steps":["trace[841236808] 'process raft request' (duration: 120.095705ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:27.015528Z","caller":"traceutil/trace.go:171","msg":"trace[2121838614] transaction","detail":"{read_only:false; response_revision:85; number_of_response:1; }","duration":"121.030885ms","start":"2026-04-13T17:07:26.894437Z","end":"2026-04-13T17:07:27.015468Z","steps":["trace[2121838614] 'process raft request' (duration: 48.516275ms)","trace[2121838614] 'compare' (duration: 71.896504ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:07:27.513498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.401909ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-13T17:07:27.513639Z","caller":"traceutil/trace.go:171","msg":"trace[736805322] linearizableReadLoop","detail":"{readStateIndex:93; appliedIndex:92; }","duration":"175.430775ms","start":"2026-04-13T17:07:27.338187Z","end":"2026-04-13T17:07:27.513618Z","steps":["trace[736805322] 'read index received' (duration: 36.773885ms)","trace[736805322] 'applied index is now lower than readState.Index' (duration: 138.65554ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:07:27.513798Z","caller":"traceutil/trace.go:171","msg":"trace[1271274982] transaction","detail":"{read_only:false; response_revision:89; number_of_response:1; }","duration":"399.025642ms","start":"2026-04-13T17:07:27.114606Z","end":"2026-04-13T17:07:27.513632Z","steps":["trace[1271274982] 'process raft request' (duration: 260.386143ms)","trace[1271274982] 'compare' (duration: 138.200361ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:07:27.514028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:27.11459Z","time spent":"399.310514ms","remote":"127.0.0.1:37478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":649,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T17:07:27.514039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.608272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T17:07:27.5141Z","caller":"traceutil/trace.go:171","msg":"trace[1797190821] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:89; }","duration":"175.936364ms","start":"2026-04-13T17:07:27.338146Z","end":"2026-04-13T17:07:27.514083Z","steps":["trace[1797190821] 'agreement among raft nodes before linearized reading' (duration: 175.528088ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:27.868696Z","caller":"traceutil/trace.go:171","msg":"trace[1199880927] transaction","detail":"{read_only:false; response_revision:95; number_of_response:1; }","duration":"125.742719ms","start":"2026-04-13T17:07:27.742925Z","end":"2026-04-13T17:07:27.868668Z","steps":["trace[1199880927] 'process raft request' (duration: 49.190416ms)","trace[1199880927] 'compare' (duration: 76.417427ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:07:28.845453Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4529668531862191618,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T17:07:29.34602Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4529668531862191618,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T17:07:29.847086Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4529668531862191618,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T17:07:29.916583Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.94903128s","expected-duration":"1s"} {"level":"info","ts":"2026-04-13T17:07:29.916951Z","caller":"traceutil/trace.go:171","msg":"trace[1482327387] transaction","detail":"{read_only:false; response_revision:98; number_of_response:1; }","duration":"1.94952242s","start":"2026-04-13T17:07:27.967405Z","end":"2026-04-13T17:07:29.916927Z","steps":["trace[1482327387] 'process raft request' (duration: 1.949400635s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:29.917047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:27.967377Z","time spent":"1.949621194s","remote":"127.0.0.1:37478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":710,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T17:07:30.34556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000936244s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-13T17:07:30.345656Z","caller":"traceutil/trace.go:171","msg":"trace[861071196] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001076829s","start":"2026-04-13T17:07:28.344558Z","end":"2026-04-13T17:07:30.345635Z","steps":["trace[861071196] 'agreement among raft nodes before linearized reading' (duration: 2.000957975s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:30.345709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:28.344539Z","time spent":"2.001155244s","remote":"127.0.0.1:37108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/13 17:07:30 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-13T17:07:30.738508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.001652488s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-13T17:07:30.738621Z","caller":"traceutil/trace.go:171","msg":"trace[1664266956] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001829506s","start":"2026-04-13T17:07:28.736766Z","end":"2026-04-13T17:07:30.738595Z","steps":["trace[1664266956] 'agreement among raft nodes before linearized reading' (duration: 2.0016805s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:30.738686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:28.736709Z","time spent":"2.001964081s","remote":"127.0.0.1:37092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T17:07:30.962586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"987.393133ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-04-13T17:07:30.962707Z","caller":"traceutil/trace.go:171","msg":"trace[565438502] linearizableReadLoop","detail":"{readStateIndex:103; appliedIndex:102; }","duration":"2.618093194s","start":"2026-04-13T17:07:28.344595Z","end":"2026-04-13T17:07:30.962688Z","steps":["trace[565438502] 'read index received' (duration: 1.572318539s)","trace[565438502] 'applied index is now lower than readState.Index' (duration: 1.045773075s)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:07:30.9628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:28.154434Z","time spent":"2.808363201s","remote":"127.0.0.1:37184","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-13T17:07:30.962975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.510781063s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-13T17:07:30.963031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.733254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T17:07:30.963043Z","caller":"traceutil/trace.go:171","msg":"trace[1828326088] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:98; }","duration":"2.510888327s","start":"2026-04-13T17:07:28.452135Z","end":"2026-04-13T17:07:30.963023Z","steps":["trace[1828326088] 'agreement among raft nodes before linearized reading' (duration: 2.510719621s)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:30.963069Z","caller":"traceutil/trace.go:171","msg":"trace[1670491741] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:98; }","duration":"125.817997ms","start":"2026-04-13T17:07:30.837237Z","end":"2026-04-13T17:07:30.963055Z","steps":["trace[1670491741] 'agreement among raft nodes before linearized reading' (duration: 125.774676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:30.963084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:28.452066Z","time spent":"2.511009123s","remote":"127.0.0.1:37380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T17:07:30.962964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.042456111s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:legacy-unknown-approver\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T17:07:30.963238Z","caller":"traceutil/trace.go:171","msg":"trace[1033342201] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:legacy-unknown-approver; range_end:; response_count:0; response_revision:98; }","duration":"1.042817095s","start":"2026-04-13T17:07:29.920402Z","end":"2026-04-13T17:07:30.963219Z","steps":["trace[1033342201] 'agreement among raft nodes before linearized reading' (duration: 1.042457861s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:30.963288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:29.920384Z","time spent":"1.042885747s","remote":"127.0.0.1:37478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/system:certificates.k8s.io:legacy-unknown-approver\" "} {"level":"warn","ts":"2026-04-13T17:07:30.963291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.972184447s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T17:07:30.963328Z","caller":"traceutil/trace.go:171","msg":"trace[7646851] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:98; }","duration":"1.972262421s","start":"2026-04-13T17:07:28.991056Z","end":"2026-04-13T17:07:30.963318Z","steps":["trace[7646851] 'agreement among raft nodes before linearized reading' (duration: 1.972195467s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:30.964217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:07:28.991029Z","time spent":"1.973160417s","remote":"127.0.0.1:37380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T17:07:31.174906Z","caller":"traceutil/trace.go:171","msg":"trace[1290307695] transaction","detail":"{read_only:false; response_revision:99; number_of_response:1; }","duration":"210.077929ms","start":"2026-04-13T17:07:30.9648Z","end":"2026-04-13T17:07:31.174878Z","steps":["trace[1290307695] 'process raft request' (duration: 204.987897ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:31.178789Z","caller":"traceutil/trace.go:171","msg":"trace[1525941932] transaction","detail":"{read_only:false; response_revision:100; number_of_response:1; }","duration":"211.943654ms","start":"2026-04-13T17:07:30.966818Z","end":"2026-04-13T17:07:31.178762Z","steps":["trace[1525941932] 'process raft request' (duration: 211.731115ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:31.178767Z","caller":"traceutil/trace.go:171","msg":"trace[1213471584] transaction","detail":"{read_only:false; response_revision:102; number_of_response:1; }","duration":"210.719933ms","start":"2026-04-13T17:07:30.968028Z","end":"2026-04-13T17:07:31.178748Z","steps":["trace[1213471584] 'process raft request' (duration: 210.681232ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:31.179324Z","caller":"traceutil/trace.go:171","msg":"trace[149485357] transaction","detail":"{read_only:false; response_revision:101; number_of_response:1; }","duration":"211.934313ms","start":"2026-04-13T17:07:30.967339Z","end":"2026-04-13T17:07:31.179273Z","steps":["trace[149485357] 'process raft request' (duration: 211.335269ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:35.319851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.459475ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T17:07:35.319985Z","caller":"traceutil/trace.go:171","msg":"trace[733219630] linearizableReadLoop","detail":"{readStateIndex:338; appliedIndex:337; }","duration":"261.155153ms","start":"2026-04-13T17:07:35.058809Z","end":"2026-04-13T17:07:35.319964Z","steps":["trace[733219630] 'read index received' (duration: 116.533941ms)","trace[733219630] 'applied index is now lower than readState.Index' (duration: 144.619582ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:07:35.320114Z","caller":"traceutil/trace.go:171","msg":"trace[66631786] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"289.984293ms","start":"2026-04-13T17:07:35.0301Z","end":"2026-04-13T17:07:35.320084Z","steps":["trace[66631786] 'process raft request' (duration: 145.187675ms)","trace[66631786] 'compare' (duration: 144.366651ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:07:35.320246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.964181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-13T17:07:35.320174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.359511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:07:35.32029Z","caller":"traceutil/trace.go:171","msg":"trace[1370998567] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:327; }","duration":"128.035484ms","start":"2026-04-13T17:07:35.192238Z","end":"2026-04-13T17:07:35.320273Z","steps":["trace[1370998567] 'agreement among raft nodes before linearized reading' (duration: 127.970721ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:35.320338Z","caller":"traceutil/trace.go:171","msg":"trace[1161296154] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pod-garbage-collector; range_end:; response_count:0; response_revision:327; }","duration":"261.553578ms","start":"2026-04-13T17:07:35.05876Z","end":"2026-04-13T17:07:35.320313Z","steps":["trace[1161296154] 'agreement among raft nodes before linearized reading' (duration: 261.364921ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:38.262974Z","caller":"traceutil/trace.go:171","msg":"trace[1831356051] linearizableReadLoop","detail":"{readStateIndex:393; appliedIndex:392; }","duration":"125.155956ms","start":"2026-04-13T17:07:38.137791Z","end":"2026-04-13T17:07:38.262947Z","steps":["trace[1831356051] 'read index received' (duration: 124.966858ms)","trace[1831356051] 'applied index is now lower than readState.Index' (duration: 188.018µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:07:38.263017Z","caller":"traceutil/trace.go:171","msg":"trace[991033959] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"297.664002ms","start":"2026-04-13T17:07:37.965316Z","end":"2026-04-13T17:07:38.26298Z","steps":["trace[991033959] 'process raft request' (duration: 297.457584ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:07:38.263114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.29555ms","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-04-13T17:07:38.263199Z","caller":"traceutil/trace.go:171","msg":"trace[666076559] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:382; }","duration":"125.395645ms","start":"2026-04-13T17:07:38.137752Z","end":"2026-04-13T17:07:38.263147Z","steps":["trace[666076559] 'agreement among raft nodes before linearized reading' (duration: 125.297961ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:46.436799Z","caller":"traceutil/trace.go:171","msg":"trace[500525028] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"112.447252ms","start":"2026-04-13T17:07:46.324307Z","end":"2026-04-13T17:07:46.436755Z","steps":["trace[500525028] 'process raft request' (duration: 112.186112ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:46.709958Z","caller":"traceutil/trace.go:171","msg":"trace[1220965974] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"113.644325ms","start":"2026-04-13T17:07:46.596292Z","end":"2026-04-13T17:07:46.709936Z","steps":["trace[1220965974] 'process raft request' (duration: 109.910273ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:46.710477Z","caller":"traceutil/trace.go:171","msg":"trace[1931372240] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"114.068419ms","start":"2026-04-13T17:07:46.596399Z","end":"2026-04-13T17:07:46.710467Z","steps":["trace[1931372240] 'process raft request' (duration: 113.727787ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:46.710614Z","caller":"traceutil/trace.go:171","msg":"trace[222710100] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"114.003896ms","start":"2026-04-13T17:07:46.596575Z","end":"2026-04-13T17:07:46.710579Z","steps":["trace[222710100] 'process raft request' (duration: 113.792309ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:07:46.71076Z","caller":"traceutil/trace.go:171","msg":"trace[480910844] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"113.951574ms","start":"2026-04-13T17:07:46.596801Z","end":"2026-04-13T17:07:46.710753Z","steps":["trace[480910844] 'process raft request' (duration: 113.616813ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:08:00.828462Z","caller":"traceutil/trace.go:171","msg":"trace[2065702387] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"609.87967ms","start":"2026-04-13T17:08:00.218561Z","end":"2026-04-13T17:08:00.828441Z","steps":["trace[2065702387] 'process raft request' (duration: 609.738636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:00.828586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:00.218538Z","time spent":"609.985854ms","remote":"127.0.0.1:37380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T17:08:00.857357Z","caller":"traceutil/trace.go:171","msg":"trace[770494352] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"587.769525ms","start":"2026-04-13T17:08:00.269557Z","end":"2026-04-13T17:08:00.857327Z","steps":["trace[770494352] 'process raft request' (duration: 587.513997ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:00.857486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:00.269527Z","time spent":"587.90119ms","remote":"127.0.0.1:37160","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-04-13T17:08:00.85749Z","caller":"traceutil/trace.go:171","msg":"trace[1655568651] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"583.841641ms","start":"2026-04-13T17:08:00.273601Z","end":"2026-04-13T17:08:00.857442Z","steps":["trace[1655568651] 'process raft request' (duration: 583.600923ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:08:00.857649Z","caller":"traceutil/trace.go:171","msg":"trace[1962811895] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"575.323969ms","start":"2026-04-13T17:08:00.282311Z","end":"2026-04-13T17:08:00.857634Z","steps":["trace[1962811895] 'process raft request' (duration: 575.007389ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:00.857727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:00.282283Z","time spent":"575.412722ms","remote":"127.0.0.1:37160","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-04-13T17:08:00.857762Z","caller":"traceutil/trace.go:171","msg":"trace[1450158305] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"569.634847ms","start":"2026-04-13T17:08:00.288111Z","end":"2026-04-13T17:08:00.857746Z","steps":["trace[1450158305] 'process raft request' (duration: 569.309767ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:08:00.857749Z","caller":"traceutil/trace.go:171","msg":"trace[1799068476] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"565.114794ms","start":"2026-04-13T17:08:00.292578Z","end":"2026-04-13T17:08:00.857693Z","steps":["trace[1799068476] 'process raft request' (duration: 564.890557ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:00.857821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:00.288088Z","time spent":"569.710381ms","remote":"127.0.0.1:37160","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-04-13T17:08:00.857787Z","caller":"traceutil/trace.go:171","msg":"trace[1366006304] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"565.100703ms","start":"2026-04-13T17:08:00.292631Z","end":"2026-04-13T17:08:00.857731Z","steps":["trace[1366006304] 'process raft request' (duration: 564.888086ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:08:00.857752Z","caller":"traceutil/trace.go:171","msg":"trace[13765978] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"580.931118ms","start":"2026-04-13T17:08:00.276739Z","end":"2026-04-13T17:08:00.85767Z","steps":["trace[13765978] 'process raft request' (duration: 580.508385ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:00.85791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:00.292568Z","time spent":"565.256029ms","remote":"127.0.0.1:37160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T17:08:00.858026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:00.292623Z","time spent":"565.253107ms","remote":"127.0.0.1:37160","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-04-13T17:08:00.858034Z","caller":"traceutil/trace.go:171","msg":"trace[1761378221] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"557.022936ms","start":"2026-04-13T17:08:00.300966Z","end":"2026-04-13T17:08:00.857989Z","steps":["trace[1761378221] 'process raft request' (duration: 556.604964ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:08:00.858096Z","caller":"traceutil/trace.go:171","msg":"trace[733920345] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"554.796835ms","start":"2026-04-13T17:08:00.303285Z","end":"2026-04-13T17:08:00.858082Z","steps":["trace[733920345] 'process raft request' (duration: 554.595058ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:00.857839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:00.273578Z","time spent":"584.115059ms","remote":"127.0.0.1:37160","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-04-13T17:08:00.858142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:00.300942Z","time spent":"557.14569ms","remote":"127.0.0.1:37160","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-04-13T17:08:00.85817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:00.303275Z","time spent":"554.862097ms","remote":"127.0.0.1:37160","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-04-13T17:08:00.858194Z","caller":"traceutil/trace.go:171","msg":"trace[1942491253] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"537.573106ms","start":"2026-04-13T17:08:00.320606Z","end":"2026-04-13T17:08:00.858179Z","steps":["trace[1942491253] 'process raft request' (duration: 537.394601ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:08:00.858217Z","caller":"traceutil/trace.go:171","msg":"trace[1667545841] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"422.747298ms","start":"2026-04-13T17:08:00.43546Z","end":"2026-04-13T17:08:00.858208Z","steps":["trace[1667545841] 'process raft request' (duration: 422.646736ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:08:00.858216Z","caller":"traceutil/trace.go:171","msg":"trace[157220941] linearizableReadLoop","detail":"{readStateIndex:545; appliedIndex:532; }","duration":"345.317881ms","start":"2026-04-13T17:08:00.512872Z","end":"2026-04-13T17:08:00.85819Z","steps":["trace[157220941] 'read index received' (duration: 315.500011ms)","trace[157220941] 'applied index is now lower than readState.Index' (duration: 29.81648ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:08:00.858257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:00.320593Z","time spent":"537.637199ms","remote":"127.0.0.1:37160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T17:08:00.858259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:00.435435Z","time spent":"422.803221ms","remote":"127.0.0.1:37160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T17:08:00.857593Z","caller":"traceutil/trace.go:171","msg":"trace[1781538786] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"569.644199ms","start":"2026-04-13T17:08:00.287929Z","end":"2026-04-13T17:08:00.857573Z","steps":["trace[1781538786] 'process raft request' (duration: 569.443472ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:00.858116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:00.2767Z","time spent":"581.30194ms","remote":"127.0.0.1:37160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T17:08:00.858373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.485767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-13T17:08:00.858431Z","caller":"traceutil/trace.go:171","msg":"trace[989998005] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:528; }","duration":"345.590961ms","start":"2026-04-13T17:08:00.512825Z","end":"2026-04-13T17:08:00.858416Z","steps":["trace[989998005] 'agreement among raft nodes before linearized reading' (duration: 345.453436ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:00.858393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:00.287904Z","time spent":"570.421994ms","remote":"127.0.0.1:37160","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-04-13T17:08:00.85855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:00.512807Z","time spent":"345.662853ms","remote":"127.0.0.1:37380","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":"info","ts":"2026-04-13T17:08:03.936255Z","caller":"traceutil/trace.go:171","msg":"trace[408242437] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"327.987132ms","start":"2026-04-13T17:08:03.60825Z","end":"2026-04-13T17:08:03.936237Z","steps":["trace[408242437] 'read index received' (duration: 327.848488ms)","trace[408242437] 'applied index is now lower than readState.Index' (duration: 138.084µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:08:03.936362Z","caller":"traceutil/trace.go:171","msg":"trace[1951657795] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"399.303128ms","start":"2026-04-13T17:08:03.537051Z","end":"2026-04-13T17:08:03.936354Z","steps":["trace[1951657795] 'process raft request' (duration: 399.092743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:03.936443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:03.537028Z","time spent":"399.360161ms","remote":"127.0.0.1:37380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T17:08:03.936694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.454168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-13T17:08:03.93674Z","caller":"traceutil/trace.go:171","msg":"trace[1661949832] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:598; }","duration":"328.515989ms","start":"2026-04-13T17:08:03.608199Z","end":"2026-04-13T17:08:03.936715Z","steps":["trace[1661949832] 'agreement among raft nodes before linearized reading' (duration: 328.435946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:03.936758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:03.608177Z","time spent":"328.576901ms","remote":"127.0.0.1:37380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-13T17:08:08.69417Z","caller":"traceutil/trace.go:171","msg":"trace[1626577987] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"494.312599ms","start":"2026-04-13T17:08:08.199828Z","end":"2026-04-13T17:08:08.694141Z","steps":["trace[1626577987] 'process raft request' (duration: 493.660799ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:08.694323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:08.199796Z","time spent":"494.449172ms","remote":"127.0.0.1:37198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T17:08:09.383373Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4529668531862192717,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T17:08:09.884442Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4529668531862192717,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T17:08:09.888517Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.131665336s","expected-duration":"1s"} {"level":"info","ts":"2026-04-13T17:08:09.889095Z","caller":"traceutil/trace.go:171","msg":"trace[1346598053] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"1.006048057s","start":"2026-04-13T17:08:08.88301Z","end":"2026-04-13T17:08:09.889058Z","steps":["trace[1346598053] 'read index received' (duration: 1.005693187s)","trace[1346598053] 'applied index is now lower than readState.Index' (duration: 353.56µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:08:09.889285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.006235514s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:08:09.889326Z","caller":"traceutil/trace.go:171","msg":"trace[1464730212] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"1.006349455s","start":"2026-04-13T17:08:08.882962Z","end":"2026-04-13T17:08:09.889312Z","steps":["trace[1464730212] 'agreement among raft nodes before linearized reading' (duration: 1.006211781s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:09.88937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:08.882938Z","time spent":"1.006423208s","remote":"127.0.0.1:37092","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-04-13T17:08:09.889398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"918.071937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-13T17:08:09.88945Z","caller":"traceutil/trace.go:171","msg":"trace[1574246919] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:631; }","duration":"918.17953ms","start":"2026-04-13T17:08:08.97126Z","end":"2026-04-13T17:08:09.889439Z","steps":["trace[1574246919] 'agreement among raft nodes before linearized reading' (duration: 917.986954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:09.88948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:08.971237Z","time spent":"918.237202ms","remote":"127.0.0.1:37380","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-04-13T17:08:09.889487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.006295724s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-13T17:08:09.889552Z","caller":"traceutil/trace.go:171","msg":"trace[1049876744] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:631; }","duration":"1.006393208s","start":"2026-04-13T17:08:08.883144Z","end":"2026-04-13T17:08:09.889537Z","steps":["trace[1049876744] 'agreement among raft nodes before linearized reading' (duration: 1.006085049s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:09.889587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:08.883132Z","time spent":"1.006447579s","remote":"127.0.0.1:37380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-13T17:08:09.889184Z","caller":"traceutil/trace.go:171","msg":"trace[1265225048] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"1.13246393s","start":"2026-04-13T17:08:08.756686Z","end":"2026-04-13T17:08:09.88915Z","steps":["trace[1265225048] 'process raft request' (duration: 1.132181471s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:09.889745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:08.756658Z","time spent":"1.133048538s","remote":"127.0.0.1:37348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T17:08:10.111296Z","caller":"traceutil/trace.go:171","msg":"trace[428377478] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:652; }","duration":"214.396893ms","start":"2026-04-13T17:08:09.896856Z","end":"2026-04-13T17:08:10.111253Z","steps":["trace[428377478] 'read index received' (duration: 29.925409ms)","trace[428377478] 'applied index is now lower than readState.Index' (duration: 184.469864ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:08:10.111779Z","caller":"traceutil/trace.go:171","msg":"trace[2037120083] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"218.169577ms","start":"2026-04-13T17:08:09.893585Z","end":"2026-04-13T17:08:10.111755Z","steps":["trace[2037120083] 'process raft request' (duration: 121.839719ms)","trace[2037120083] 'compare' (duration: 95.589516ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:08:10.111991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.021828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-13T17:08:10.111979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.105815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-13T17:08:10.11209Z","caller":"traceutil/trace.go:171","msg":"trace[168899607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:633; }","duration":"149.153443ms","start":"2026-04-13T17:08:09.96292Z","end":"2026-04-13T17:08:10.112074Z","steps":["trace[168899607] 'agreement among raft nodes before linearized reading' (duration: 148.906636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:10.111781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.568528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:08:10.11225Z","caller":"traceutil/trace.go:171","msg":"trace[857495580] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"214.117655ms","start":"2026-04-13T17:08:09.898119Z","end":"2026-04-13T17:08:10.112237Z","steps":["trace[857495580] 'agreement among raft nodes before linearized reading' (duration: 213.558218ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:10.11181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.72873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-13T17:08:10.112351Z","caller":"traceutil/trace.go:171","msg":"trace[457579514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:633; }","duration":"149.293727ms","start":"2026-04-13T17:08:09.963036Z","end":"2026-04-13T17:08:10.11233Z","steps":["trace[457579514] 'agreement among raft nodes before linearized reading' (duration: 148.672079ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:08:10.112641Z","caller":"traceutil/trace.go:171","msg":"trace[531458161] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:633; }","duration":"215.248929ms","start":"2026-04-13T17:08:09.896835Z","end":"2026-04-13T17:08:10.112083Z","steps":["trace[531458161] 'agreement among raft nodes before linearized reading' (duration: 214.658602ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:08:24.532444Z","caller":"traceutil/trace.go:171","msg":"trace[1695842334] linearizableReadLoop","detail":"{readStateIndex:805; appliedIndex:804; }","duration":"297.682302ms","start":"2026-04-13T17:08:24.234726Z","end":"2026-04-13T17:08:24.532408Z","steps":["trace[1695842334] 'read index received' (duration: 297.530057ms)","trace[1695842334] 'applied index is now lower than readState.Index' (duration: 150.175µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:08:24.53255Z","caller":"traceutil/trace.go:171","msg":"trace[1943913777] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"305.047836ms","start":"2026-04-13T17:08:24.227451Z","end":"2026-04-13T17:08:24.532499Z","steps":["trace[1943913777] 'process raft request' (duration: 304.785778ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:24.532887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:24.227419Z","time spent":"305.282361ms","remote":"127.0.0.1:37380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T17:08:24.53292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.155375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-13T17:08:24.533019Z","caller":"traceutil/trace.go:171","msg":"trace[365353071] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:780; }","duration":"298.30361ms","start":"2026-04-13T17:08:24.234698Z","end":"2026-04-13T17:08:24.533001Z","steps":["trace[365353071] 'agreement among raft nodes before linearized reading' (duration: 297.999581ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:24.53317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.530323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-13T17:08:24.533236Z","caller":"traceutil/trace.go:171","msg":"trace[48849232] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:780; }","duration":"295.652657ms","start":"2026-04-13T17:08:24.237564Z","end":"2026-04-13T17:08:24.533217Z","steps":["trace[48849232] 'agreement among raft nodes before linearized reading' (duration: 295.285987ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:08:27.712163Z","caller":"traceutil/trace.go:171","msg":"trace[1020482703] linearizableReadLoop","detail":"{readStateIndex:822; appliedIndex:821; }","duration":"299.581586ms","start":"2026-04-13T17:08:27.412544Z","end":"2026-04-13T17:08:27.712125Z","steps":["trace[1020482703] 'read index received' (duration: 299.35388ms)","trace[1020482703] 'applied index is now lower than readState.Index' (duration: 226.316µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:08:27.71228Z","caller":"traceutil/trace.go:171","msg":"trace[1644729679] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"557.857381ms","start":"2026-04-13T17:08:27.154396Z","end":"2026-04-13T17:08:27.712254Z","steps":["trace[1644729679] 'process raft request' (duration: 557.505752ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:27.712647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.09123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-13T17:08:27.712645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:27.154364Z","time spent":"557.973224ms","remote":"127.0.0.1:37304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T17:08:27.712756Z","caller":"traceutil/trace.go:171","msg":"trace[140021070] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:797; }","duration":"300.202782ms","start":"2026-04-13T17:08:27.412497Z","end":"2026-04-13T17:08:27.7127Z","steps":["trace[140021070] 'agreement among raft nodes before linearized reading' (duration: 299.817242ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:27.712807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:08:27.41248Z","time spent":"300.315075ms","remote":"127.0.0.1:37630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":2,"response size":31,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"warn","ts":"2026-04-13T17:08:27.72492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.871291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T17:08:27.724997Z","caller":"traceutil/trace.go:171","msg":"trace[2065642050] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:798; }","duration":"282.992085ms","start":"2026-04-13T17:08:27.441983Z","end":"2026-04-13T17:08:27.724975Z","steps":["trace[2065642050] 'agreement among raft nodes before linearized reading' (duration: 282.833811ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:08:27.725079Z","caller":"traceutil/trace.go:171","msg":"trace[921192197] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"103.066645ms","start":"2026-04-13T17:08:27.621989Z","end":"2026-04-13T17:08:27.725056Z","steps":["trace[921192197] 'process raft request' (duration: 102.639234ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:09:55.42786Z","caller":"traceutil/trace.go:171","msg":"trace[1377179301] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"206.609119ms","start":"2026-04-13T17:09:55.221221Z","end":"2026-04-13T17:09:55.42783Z","steps":["trace[1377179301] 'process raft request' (duration: 206.413375ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:10:51.849854Z","caller":"traceutil/trace.go:171","msg":"trace[1840893075] transaction","detail":"{read_only:false; response_revision:1443; number_of_response:1; }","duration":"312.145595ms","start":"2026-04-13T17:10:51.537672Z","end":"2026-04-13T17:10:51.849818Z","steps":["trace[1840893075] 'process raft request' (duration: 311.947171ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:10:51.850045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:10:51.537649Z","time spent":"312.289168ms","remote":"127.0.0.1:37380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T17:10:51.849994Z","caller":"traceutil/trace.go:171","msg":"trace[100176763] linearizableReadLoop","detail":"{readStateIndex:1503; appliedIndex:1502; }","duration":"291.328157ms","start":"2026-04-13T17:10:51.558612Z","end":"2026-04-13T17:10:51.849941Z","steps":["trace[100176763] 'read index received' (duration: 290.95254ms)","trace[100176763] 'applied index is now lower than readState.Index' (duration: 372.227µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:10:51.850298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.635803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/envoy-gateway-system/\" range_end:\"/registry/persistentvolumeclaims/envoy-gateway-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:10:51.850377Z","caller":"traceutil/trace.go:171","msg":"trace[243689882] range","detail":"{range_begin:/registry/persistentvolumeclaims/envoy-gateway-system/; range_end:/registry/persistentvolumeclaims/envoy-gateway-system0; response_count:0; response_revision:1443; }","duration":"291.755865ms","start":"2026-04-13T17:10:51.558599Z","end":"2026-04-13T17:10:51.850355Z","steps":["trace[243689882] 'agreement among raft nodes before linearized reading' (duration: 291.547161ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:10:51.850389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.531018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-lwmns\" ","response":"range_response_count:1 size:5484"} {"level":"info","ts":"2026-04-13T17:10:51.850444Z","caller":"traceutil/trace.go:171","msg":"trace[799924526] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-lwmns; range_end:; response_count:1; response_revision:1443; }","duration":"284.630789ms","start":"2026-04-13T17:10:51.565792Z","end":"2026-04-13T17:10:51.850423Z","steps":["trace[799924526] 'agreement among raft nodes before linearized reading' (duration: 284.392405ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:10:51.850595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.422508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/\" range_end:\"/registry/persistentvolumeclaims/default0\" limit:500 ","response":"range_response_count:1 size:1465"} {"level":"warn","ts":"2026-04-13T17:10:51.850737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.45121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-13T17:10:51.850782Z","caller":"traceutil/trace.go:171","msg":"trace[766573511] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1443; }","duration":"256.539734ms","start":"2026-04-13T17:10:51.594233Z","end":"2026-04-13T17:10:51.850772Z","steps":["trace[766573511] 'agreement among raft nodes before linearized reading' (duration: 256.3474ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:10:51.850796Z","caller":"traceutil/trace.go:171","msg":"trace[786091617] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/; range_end:/registry/persistentvolumeclaims/default0; response_count:1; response_revision:1443; }","duration":"225.571711ms","start":"2026-04-13T17:10:51.625102Z","end":"2026-04-13T17:10:51.850673Z","steps":["trace[786091617] 'agreement among raft nodes before linearized reading' (duration: 225.183463ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:11:08.064834Z","caller":"traceutil/trace.go:171","msg":"trace[267297302] transaction","detail":"{read_only:false; response_revision:1495; number_of_response:1; }","duration":"104.31694ms","start":"2026-04-13T17:11:07.960483Z","end":"2026-04-13T17:11:08.0648Z","steps":["trace[267297302] 'process raft request' (duration: 104.047085ms)"],"step_count":1}