{"level":"warn","ts":"2026-04-13T22:41:35.121735Z","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-13T22:41:35.121888Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.132:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.132:2380","--initial-cluster=instance=https://199.204.45.132:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.132:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.132: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-13T22:41:35.122078Z","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-13T22:41:35.122094Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.132:2380"]} {"level":"info","ts":"2026-04-13T22:41:35.122145Z","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-13T22:41:35.122777Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"]} {"level":"info","ts":"2026-04-13T22:41:35.122847Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.132: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-13T22:41:35.128824Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.637369ms"} {"level":"info","ts":"2026-04-13T22:41:35.135863Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"56c01ea8fdc90390","cluster-id":"c930fe821aab8609"} {"level":"info","ts":"2026-04-13T22:41:35.135943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=()"} {"level":"info","ts":"2026-04-13T22:41:35.135971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 0"} {"level":"info","ts":"2026-04-13T22:41:35.135984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 56c01ea8fdc90390 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-13T22:41:35.136001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 1"} {"level":"info","ts":"2026-04-13T22:41:35.136038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"warn","ts":"2026-04-13T22:41:35.141384Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-13T22:41:35.14243Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-13T22:41:35.143989Z","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-13T22:41:35.146205Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"56c01ea8fdc90390","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-13T22:41:35.146317Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"56c01ea8fdc90390","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-13T22:41:35.146315Z","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-13T22:41:35.146404Z","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-13T22:41:35.146418Z","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-13T22:41:35.148639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"info","ts":"2026-04-13T22:41:35.148844Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","added-peer-id":"56c01ea8fdc90390","added-peer-peer-urls":["https://199.204.45.132:2380"]} {"level":"info","ts":"2026-04-13T22:41:35.151112Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-04-13T22:41:35.151197Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-04-13T22:41:35.150997Z","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-13T22:41:35.15213Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"56c01ea8fdc90390","initial-advertise-peer-urls":["https://199.204.45.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-13T22:41:35.152212Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-13T22:41:36.036241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 is starting a new election at term 1"} {"level":"info","ts":"2026-04-13T22:41:36.036303Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-13T22:41:36.036382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgPreVoteResp from 56c01ea8fdc90390 at term 1"} {"level":"info","ts":"2026-04-13T22:41:36.03641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became candidate at term 2"} {"level":"info","ts":"2026-04-13T22:41:36.036453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgVoteResp from 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-04-13T22:41:36.036496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became leader at term 2"} {"level":"info","ts":"2026-04-13T22:41:36.0366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 56c01ea8fdc90390 elected leader 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-04-13T22:41:36.039132Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T22:41:36.041757Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"56c01ea8fdc90390","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.132:2379]}","request-path":"/0/members/56c01ea8fdc90390/attributes","cluster-id":"c930fe821aab8609","publish-timeout":"7s"} {"level":"info","ts":"2026-04-13T22:41:36.041804Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T22:41:36.041861Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T22:41:36.041967Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-13T22:41:36.042021Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-13T22:41:36.04512Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-13T22:41:36.04753Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.132:2379"} {"level":"info","ts":"2026-04-13T22:41:36.056223Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T22:41:36.056335Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T22:41:36.056383Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-13T22:41:39.151786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.88605ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-13T22:41:39.151948Z","caller":"traceutil/trace.go:171","msg":"trace[1444334228] transaction","detail":"{read_only:false; response_revision:181; number_of_response:1; }","duration":"175.342674ms","start":"2026-04-13T22:41:38.97658Z","end":"2026-04-13T22:41:39.151923Z","steps":["trace[1444334228] 'process raft request' (duration: 68.638568ms)","trace[1444334228] 'compare' (duration: 105.670396ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T22:41:39.331003Z","caller":"traceutil/trace.go:171","msg":"trace[650827063] transaction","detail":"{read_only:false; response_revision:184; number_of_response:1; }","duration":"134.923243ms","start":"2026-04-13T22:41:39.196042Z","end":"2026-04-13T22:41:39.330965Z","steps":["trace[650827063] 'process raft request' (duration: 92.91647ms)","trace[650827063] 'compare' (duration: 41.84057ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T22:41:39.528764Z","caller":"traceutil/trace.go:171","msg":"trace[1927530076] linearizableReadLoop","detail":"{readStateIndex:191; appliedIndex:190; }","duration":"149.013875ms","start":"2026-04-13T22:41:39.379722Z","end":"2026-04-13T22:41:39.528736Z","steps":["trace[1927530076] 'read index received' (duration: 55.875631ms)","trace[1927530076] 'applied index is now lower than readState.Index' (duration: 93.137194ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T22:41:39.528965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.202079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T22:41:39.528935Z","caller":"traceutil/trace.go:171","msg":"trace[128362294] transaction","detail":"{read_only:false; response_revision:187; number_of_response:1; }","duration":"149.372063ms","start":"2026-04-13T22:41:39.379511Z","end":"2026-04-13T22:41:39.528883Z","steps":["trace[128362294] 'process raft request' (duration: 56.131338ms)","trace[128362294] 'compare' (duration: 92.97848ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T22:41:39.529009Z","caller":"traceutil/trace.go:171","msg":"trace[1462267572] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:187; }","duration":"149.303701ms","start":"2026-04-13T22:41:39.379694Z","end":"2026-04-13T22:41:39.528998Z","steps":["trace[1462267572] 'agreement among raft nodes before linearized reading' (duration: 149.180469ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:41:39.529052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.383163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-13T22:41:39.529118Z","caller":"traceutil/trace.go:171","msg":"trace[1227090291] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:187; }","duration":"148.490016ms","start":"2026-04-13T22:41:39.38061Z","end":"2026-04-13T22:41:39.5291Z","steps":["trace[1227090291] 'agreement among raft nodes before linearized reading' (duration: 148.349853ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:41:39.727947Z","caller":"traceutil/trace.go:171","msg":"trace[607732450] linearizableReadLoop","detail":"{readStateIndex:193; appliedIndex:192; }","duration":"159.186232ms","start":"2026-04-13T22:41:39.568733Z","end":"2026-04-13T22:41:39.727919Z","steps":["trace[607732450] 'read index received' (duration: 126.101871ms)","trace[607732450] 'applied index is now lower than readState.Index' (duration: 33.080881ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T22:41:39.727978Z","caller":"traceutil/trace.go:171","msg":"trace[1879196427] transaction","detail":"{read_only:false; response_revision:189; number_of_response:1; }","duration":"192.989587ms","start":"2026-04-13T22:41:39.534962Z","end":"2026-04-13T22:41:39.727951Z","steps":["trace[1879196427] 'process raft request' (duration: 159.925827ms)","trace[1879196427] 'compare' (duration: 32.921018ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T22:41:39.728158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.403506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system:controller:bootstrap-signer\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T22:41:39.728224Z","caller":"traceutil/trace.go:171","msg":"trace[2111171560] range","detail":"{range_begin:/registry/rolebindings/kube-system/system:controller:bootstrap-signer; range_end:; response_count:0; response_revision:189; }","duration":"159.516478ms","start":"2026-04-13T22:41:39.56869Z","end":"2026-04-13T22:41:39.728207Z","steps":["trace[2111171560] 'agreement among raft nodes before linearized reading' (duration: 159.395876ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:41:39.935718Z","caller":"traceutil/trace.go:171","msg":"trace[145175701] transaction","detail":"{read_only:false; response_revision:191; number_of_response:1; }","duration":"203.105984ms","start":"2026-04-13T22:41:39.732588Z","end":"2026-04-13T22:41:39.935694Z","steps":["trace[145175701] 'process raft request' (duration: 203.052083ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:41:39.935796Z","caller":"traceutil/trace.go:171","msg":"trace[372337243] transaction","detail":"{read_only:false; response_revision:190; number_of_response:1; }","duration":"205.378807ms","start":"2026-04-13T22:41:39.730351Z","end":"2026-04-13T22:41:39.93573Z","steps":["trace[372337243] 'process raft request' (duration: 169.94798ms)","trace[372337243] 'compare' (duration: 35.176242ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T22:41:40.330445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.14759ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-13T22:41:40.330551Z","caller":"traceutil/trace.go:171","msg":"trace[362972407] transaction","detail":"{read_only:false; response_revision:192; number_of_response:1; }","duration":"385.90229ms","start":"2026-04-13T22:41:39.944628Z","end":"2026-04-13T22:41:40.33053Z","steps":["trace[362972407] 'process raft request' (duration: 283.603697ms)","trace[362972407] 'compare' (duration: 101.991637ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T22:41:40.330606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:41:39.944602Z","time spent":"385.984061ms","remote":"127.0.0.1:45718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":718,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T22:41:41.28906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.969767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-13T22:41:41.289156Z","caller":"traceutil/trace.go:171","msg":"trace[1966889681] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:218; }","duration":"123.11359ms","start":"2026-04-13T22:41:41.166012Z","end":"2026-04-13T22:41:41.289125Z","steps":["trace[1966889681] 'range keys from in-memory index tree' (duration: 122.836464ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:41:41.483804Z","caller":"traceutil/trace.go:171","msg":"trace[249692985] transaction","detail":"{read_only:false; response_revision:222; number_of_response:1; }","duration":"122.297794ms","start":"2026-04-13T22:41:41.36148Z","end":"2026-04-13T22:41:41.483778Z","steps":["trace[249692985] 'process raft request' (duration: 50.710104ms)","trace[249692985] 'compare' (duration: 71.436267ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T22:41:41.671036Z","caller":"traceutil/trace.go:171","msg":"trace[1432281826] transaction","detail":"{read_only:false; response_revision:223; number_of_response:1; }","duration":"304.840368ms","start":"2026-04-13T22:41:41.36615Z","end":"2026-04-13T22:41:41.67099Z","steps":["trace[1432281826] 'process raft request' (duration: 290.952198ms)","trace[1432281826] 'compare' (duration: 13.470152ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T22:41:41.671225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.892879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-4lam5i\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T22:41:41.671253Z","caller":"traceutil/trace.go:171","msg":"trace[1598841631] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-4lam5i; range_end:; response_count:0; response_revision:223; }","duration":"183.96376ms","start":"2026-04-13T22:41:41.487283Z","end":"2026-04-13T22:41:41.671247Z","steps":["trace[1598841631] 'agreement among raft nodes before linearized reading' (duration: 183.881029ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:41:41.671248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:41:41.366134Z","time spent":"305.044161ms","remote":"127.0.0.1:45580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T22:41:41.671141Z","caller":"traceutil/trace.go:171","msg":"trace[1257653823] linearizableReadLoop","detail":"{readStateIndex:229; appliedIndex:228; }","duration":"183.801147ms","start":"2026-04-13T22:41:41.487327Z","end":"2026-04-13T22:41:41.671128Z","steps":["trace[1257653823] 'read index received' (duration: 169.813795ms)","trace[1257653823] 'applied index is now lower than readState.Index' (duration: 13.985962ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T22:41:46.98484Z","caller":"traceutil/trace.go:171","msg":"trace[1415981491] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"103.900086ms","start":"2026-04-13T22:41:46.880908Z","end":"2026-04-13T22:41:46.984808Z","steps":["trace[1415981491] 'process raft request' (duration: 32.30485ms)","trace[1415981491] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/minions/instance; req_size:4358; } (duration: 71.352752ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T22:41:48.751501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.219447ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-13T22:41:48.751642Z","caller":"traceutil/trace.go:171","msg":"trace[443881652] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"210.483124ms","start":"2026-04-13T22:41:48.541135Z","end":"2026-04-13T22:41:48.751618Z","steps":["trace[443881652] 'process raft request' (duration: 83.945261ms)","trace[443881652] 'compare' (duration: 126.096835ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T22:41:52.148867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.737261ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T22:41:52.149098Z","caller":"traceutil/trace.go:171","msg":"trace[1845400597] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"318.977513ms","start":"2026-04-13T22:41:51.830103Z","end":"2026-04-13T22:41:52.149081Z","steps":["trace[1845400597] 'process raft request' (duration: 318.893291ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:41:52.149124Z","caller":"traceutil/trace.go:171","msg":"trace[514610507] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"320.193617ms","start":"2026-04-13T22:41:51.8289Z","end":"2026-04-13T22:41:52.149094Z","steps":["trace[514610507] 'process raft request' (duration: 133.958645ms)","trace[514610507] 'compare' (duration: 185.458086ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T22:41:52.149171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:41:51.830096Z","time spent":"319.041065ms","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T22:41:52.14928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:41:51.828883Z","time spent":"320.302789ms","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T22:41:53.549199Z","caller":"traceutil/trace.go:171","msg":"trace[1143282019] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"102.763237ms","start":"2026-04-13T22:41:53.446401Z","end":"2026-04-13T22:41:53.549164Z","steps":["trace[1143282019] 'process raft request' (duration: 102.640025ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:41:55.189317Z","caller":"traceutil/trace.go:171","msg":"trace[1813685044] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"103.206248ms","start":"2026-04-13T22:41:55.086077Z","end":"2026-04-13T22:41:55.189283Z","steps":["trace[1813685044] 'process raft request' (duration: 102.976295ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:41:56.278243Z","caller":"traceutil/trace.go:171","msg":"trace[196025307] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"104.997771ms","start":"2026-04-13T22:41:56.173225Z","end":"2026-04-13T22:41:56.278223Z","steps":["trace[196025307] 'process raft request' (duration: 104.90355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:00.916157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:00.484731Z","time spent":"431.42163ms","remote":"127.0.0.1:45388","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-13T22:42:04.456411Z","caller":"traceutil/trace.go:171","msg":"trace[335324776] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"144.534573ms","start":"2026-04-13T22:42:04.311843Z","end":"2026-04-13T22:42:04.456378Z","steps":["trace[335324776] 'process raft request' (duration: 48.106086ms)","trace[335324776] 'compare' (duration: 96.302015ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T22:42:05.466483Z","caller":"traceutil/trace.go:171","msg":"trace[1610136518] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"519.68912ms","start":"2026-04-13T22:42:04.946771Z","end":"2026-04-13T22:42:05.46646Z","steps":["trace[1610136518] 'process raft request' (duration: 519.570739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:05.466643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:04.946746Z","time spent":"519.823533ms","remote":"127.0.0.1:45402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T22:42:05.476385Z","caller":"traceutil/trace.go:171","msg":"trace[1554005032] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"522.875227ms","start":"2026-04-13T22:42:04.953487Z","end":"2026-04-13T22:42:05.476363Z","steps":["trace[1554005032] 'process raft request' (duration: 522.721455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:05.476546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:04.953457Z","time spent":"523.036119ms","remote":"127.0.0.1:45402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T22:42:05.476607Z","caller":"traceutil/trace.go:171","msg":"trace[776554710] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"511.595544ms","start":"2026-04-13T22:42:04.964991Z","end":"2026-04-13T22:42:05.476587Z","steps":["trace[776554710] 'process raft request' (duration: 511.3772ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:05.476665Z","caller":"traceutil/trace.go:171","msg":"trace[871940440] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"511.617145ms","start":"2026-04-13T22:42:04.96504Z","end":"2026-04-13T22:42:05.476657Z","steps":["trace[871940440] 'process raft request' (duration: 511.350561ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:05.476419Z","caller":"traceutil/trace.go:171","msg":"trace[1093566001] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"518.097748ms","start":"2026-04-13T22:42:04.958299Z","end":"2026-04-13T22:42:05.476397Z","steps":["trace[1093566001] 'process raft request' (duration: 518.007217ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:05.476759Z","caller":"traceutil/trace.go:171","msg":"trace[1791372692] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"483.976805ms","start":"2026-04-13T22:42:04.992772Z","end":"2026-04-13T22:42:05.476749Z","steps":["trace[1791372692] 'process raft request' (duration: 483.803641ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:05.476755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:04.965037Z","time spent":"511.663136ms","remote":"127.0.0.1:45402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T22:42:05.476767Z","caller":"traceutil/trace.go:171","msg":"trace[1108665840] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"499.985497ms","start":"2026-04-13T22:42:04.976756Z","end":"2026-04-13T22:42:05.476741Z","steps":["trace[1108665840] 'process raft request' (duration: 499.763773ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:05.476776Z","caller":"traceutil/trace.go:171","msg":"trace[880283359] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"511.726027ms","start":"2026-04-13T22:42:04.964938Z","end":"2026-04-13T22:42:05.476664Z","steps":["trace[880283359] 'process raft request' (duration: 511.405141ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:05.476808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:04.992761Z","time spent":"484.027265ms","remote":"127.0.0.1:45402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T22:42:05.476838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:04.964922Z","time spent":"511.888099ms","remote":"127.0.0.1:45402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T22:42:05.476871Z","caller":"traceutil/trace.go:171","msg":"trace[1450650033] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"511.786217ms","start":"2026-04-13T22:42:04.965075Z","end":"2026-04-13T22:42:05.476862Z","steps":["trace[1450650033] 'process raft request' (duration: 511.394301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:05.476841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:04.976744Z","time spent":"500.062169ms","remote":"127.0.0.1:45402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T22:42:05.476918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:04.96507Z","time spent":"511.827938ms","remote":"127.0.0.1:45402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T22:42:05.476933Z","caller":"traceutil/trace.go:171","msg":"trace[876320057] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"458.682437ms","start":"2026-04-13T22:42:05.018241Z","end":"2026-04-13T22:42:05.476923Z","steps":["trace[876320057] 'process raft request' (duration: 458.441554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:05.476977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:05.018222Z","time spent":"458.733659ms","remote":"127.0.0.1:45402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T22:42:05.476706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:04.964988Z","time spent":"511.679496ms","remote":"127.0.0.1:45402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T22:42:05.477021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:04.958284Z","time spent":"518.479045ms","remote":"127.0.0.1:45402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T22:42:05.477195Z","caller":"traceutil/trace.go:171","msg":"trace[1101912419] linearizableReadLoop","detail":"{readStateIndex:535; appliedIndex:524; }","duration":"354.928037ms","start":"2026-04-13T22:42:05.12225Z","end":"2026-04-13T22:42:05.477178Z","steps":["trace[1101912419] 'read index received' (duration: 344.476994ms)","trace[1101912419] 'applied index is now lower than readState.Index' (duration: 10.450253ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T22:42:05.477257Z","caller":"traceutil/trace.go:171","msg":"trace[1079063350] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"458.077278ms","start":"2026-04-13T22:42:05.019172Z","end":"2026-04-13T22:42:05.477249Z","steps":["trace[1079063350] 'process raft request' (duration: 457.560861ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:05.477321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:05.019141Z","time spent":"458.154709ms","remote":"127.0.0.1:45402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T22:42:05.478767Z","caller":"traceutil/trace.go:171","msg":"trace[1572212217] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"362.055591ms","start":"2026-04-13T22:42:05.116702Z","end":"2026-04-13T22:42:05.478757Z","steps":["trace[1572212217] 'process raft request' (duration: 360.129953ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:05.478812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:05.116677Z","time spent":"362.116372ms","remote":"127.0.0.1:45402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T22:42:05.478921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.666662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T22:42:05.478945Z","caller":"traceutil/trace.go:171","msg":"trace[1349505578] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:518; }","duration":"356.707133ms","start":"2026-04-13T22:42:05.122232Z","end":"2026-04-13T22:42:05.478939Z","steps":["trace[1349505578] 'agreement among raft nodes before linearized reading' (duration: 356.646062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:05.478969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:05.122226Z","time spent":"356.740114ms","remote":"127.0.0.1:45346","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-13T22:42:05.485109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.536211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-13T22:42:05.485182Z","caller":"traceutil/trace.go:171","msg":"trace[415061827] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:520; }","duration":"187.657882ms","start":"2026-04-13T22:42:05.297516Z","end":"2026-04-13T22:42:05.485174Z","steps":["trace[415061827] 'agreement among raft nodes before linearized reading' (duration: 187.491518ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:06.282531Z","caller":"traceutil/trace.go:171","msg":"trace[1919802322] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"227.571179ms","start":"2026-04-13T22:42:06.054929Z","end":"2026-04-13T22:42:06.2825Z","steps":["trace[1919802322] 'process raft request' (duration: 227.368387ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:06.283442Z","caller":"traceutil/trace.go:171","msg":"trace[457582442] linearizableReadLoop","detail":"{readStateIndex:594; appliedIndex:594; }","duration":"154.656333ms","start":"2026-04-13T22:42:06.128765Z","end":"2026-04-13T22:42:06.283421Z","steps":["trace[457582442] 'read index received' (duration: 154.649313ms)","trace[457582442] 'applied index is now lower than readState.Index' (duration: 5.35µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T22:42:06.283569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.783505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T22:42:06.283605Z","caller":"traceutil/trace.go:171","msg":"trace[181021518] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:572; }","duration":"154.860776ms","start":"2026-04-13T22:42:06.128735Z","end":"2026-04-13T22:42:06.283596Z","steps":["trace[181021518] 'agreement among raft nodes before linearized reading' (duration: 154.778865ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:06.294008Z","caller":"traceutil/trace.go:171","msg":"trace[473116969] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"141.015452ms","start":"2026-04-13T22:42:06.152964Z","end":"2026-04-13T22:42:06.293979Z","steps":["trace[473116969] 'process raft request' (duration: 135.927579ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:11.776414Z","caller":"traceutil/trace.go:171","msg":"trace[1597690671] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"447.47643ms","start":"2026-04-13T22:42:11.328912Z","end":"2026-04-13T22:42:11.776389Z","steps":["trace[1597690671] 'process raft request' (duration: 445.333377ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:11.776367Z","caller":"traceutil/trace.go:171","msg":"trace[1436799535] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:635; }","duration":"235.314798ms","start":"2026-04-13T22:42:11.541Z","end":"2026-04-13T22:42:11.776315Z","steps":["trace[1436799535] 'read index received' (duration: 232.561326ms)","trace[1436799535] 'applied index is now lower than readState.Index' (duration: 2.752482ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T22:42:11.776669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.659003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-13T22:42:11.776736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:11.328878Z","time spent":"447.609891ms","remote":"127.0.0.1:45450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T22:42:11.776763Z","caller":"traceutil/trace.go:171","msg":"trace[1742105490] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:613; }","duration":"235.811755ms","start":"2026-04-13T22:42:11.540936Z","end":"2026-04-13T22:42:11.776747Z","steps":["trace[1742105490] 'agreement among raft nodes before linearized reading' (duration: 235.518761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:11.776796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.267618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-13T22:42:11.776854Z","caller":"traceutil/trace.go:171","msg":"trace[1883106765] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:613; }","duration":"127.359959ms","start":"2026-04-13T22:42:11.649477Z","end":"2026-04-13T22:42:11.776837Z","steps":["trace[1883106765] 'agreement among raft nodes before linearized reading' (duration: 127.196067ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:12.357597Z","caller":"traceutil/trace.go:171","msg":"trace[72020943] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"576.08456ms","start":"2026-04-13T22:42:11.781486Z","end":"2026-04-13T22:42:12.357571Z","steps":["trace[72020943] 'process raft request' (duration: 575.813246ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:12.357735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:11.781465Z","time spent":"576.196382ms","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T22:42:12.357793Z","caller":"traceutil/trace.go:171","msg":"trace[1769021978] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"568.074771ms","start":"2026-04-13T22:42:11.7897Z","end":"2026-04-13T22:42:12.357775Z","steps":["trace[1769021978] 'process raft request' (duration: 567.805297ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:12.357897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:11.789673Z","time spent":"568.168693ms","remote":"127.0.0.1:45566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T22:42:12.37687Z","caller":"traceutil/trace.go:171","msg":"trace[1534387832] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"545.000326ms","start":"2026-04-13T22:42:11.831825Z","end":"2026-04-13T22:42:12.376825Z","steps":["trace[1534387832] 'process raft request' (duration: 544.815924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:12.377024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:11.83181Z","time spent":"545.144649ms","remote":"127.0.0.1:45868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T22:42:12.864529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.948867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-13T22:42:12.864612Z","caller":"traceutil/trace.go:171","msg":"trace[841970611] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:618; }","duration":"385.061809ms","start":"2026-04-13T22:42:12.479533Z","end":"2026-04-13T22:42:12.864595Z","steps":["trace[841970611] 'range keys from in-memory index tree' (duration: 384.757175ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:12.864661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:12.479461Z","time spent":"385.191241ms","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T22:42:13.626232Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256878390527763743,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T22:42:13.987304Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.20736075s","expected-duration":"1s"} {"level":"info","ts":"2026-04-13T22:42:13.988549Z","caller":"traceutil/trace.go:171","msg":"trace[2032578212] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"1.209983148s","start":"2026-04-13T22:42:12.778547Z","end":"2026-04-13T22:42:13.98853Z","steps":["trace[2032578212] 'process raft request' (duration: 1.209318418s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:13.98881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:12.778521Z","time spent":"1.210094281s","remote":"127.0.0.1:45450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T22:42:14.150853Z","caller":"traceutil/trace.go:171","msg":"trace[597131932] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"104.543389ms","start":"2026-04-13T22:42:14.04628Z","end":"2026-04-13T22:42:14.150824Z","steps":["trace[597131932] 'process raft request' (duration: 104.503208ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:14.150942Z","caller":"traceutil/trace.go:171","msg":"trace[925181977] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"1.282448581s","start":"2026-04-13T22:42:12.868472Z","end":"2026-04-13T22:42:14.15092Z","steps":["trace[925181977] 'process raft request' (duration: 1.25872103s)","trace[925181977] 'compare' (duration: 23.353316ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T22:42:14.151046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:12.868453Z","time spent":"1.282534002s","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T22:42:14.151168Z","caller":"traceutil/trace.go:171","msg":"trace[789284976] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"923.357748ms","start":"2026-04-13T22:42:13.227802Z","end":"2026-04-13T22:42:14.15116Z","steps":["trace[789284976] 'process raft request' (duration: 922.889822ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:14.151169Z","caller":"traceutil/trace.go:171","msg":"trace[1691797955] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"795.288211ms","start":"2026-04-13T22:42:13.355869Z","end":"2026-04-13T22:42:14.151157Z","steps":["trace[1691797955] 'process raft request' (duration: 794.868425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:14.151201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:13.227777Z","time spent":"923.405469ms","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T22:42:14.151266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:13.355844Z","time spent":"795.354002ms","remote":"127.0.0.1:45550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T22:42:14.151355Z","caller":"traceutil/trace.go:171","msg":"trace[136539389] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:641; }","duration":"1.025570565s","start":"2026-04-13T22:42:13.12576Z","end":"2026-04-13T22:42:14.151331Z","steps":["trace[136539389] 'read index received' (duration: 861.825558ms)","trace[136539389] 'applied index is now lower than readState.Index' (duration: 163.743067ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T22:42:14.151527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.025750347s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T22:42:14.151568Z","caller":"traceutil/trace.go:171","msg":"trace[1206755905] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"1.025804658s","start":"2026-04-13T22:42:13.125752Z","end":"2026-04-13T22:42:14.151557Z","steps":["trace[1206755905] 'agreement among raft nodes before linearized reading' (duration: 1.025723387s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:14.1516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.400228ms","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-13T22:42:14.151599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:13.125688Z","time spent":"1.02590368s","remote":"127.0.0.1:45346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-13T22:42:14.151628Z","caller":"traceutil/trace.go:171","msg":"trace[1241495288] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:623; }","duration":"328.469439ms","start":"2026-04-13T22:42:13.82315Z","end":"2026-04-13T22:42:14.15162Z","steps":["trace[1241495288] 'agreement among raft nodes before linearized reading' (duration: 328.366228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:14.151648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:13.82313Z","time spent":"328.513059ms","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T22:42:17.955417Z","caller":"traceutil/trace.go:171","msg":"trace[699510346] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"185.939621ms","start":"2026-04-13T22:42:17.769451Z","end":"2026-04-13T22:42:17.955391Z","steps":["trace[699510346] 'process raft request' (duration: 185.85539ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:17.955442Z","caller":"traceutil/trace.go:171","msg":"trace[1219129936] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"197.557409ms","start":"2026-04-13T22:42:17.757848Z","end":"2026-04-13T22:42:17.955406Z","steps":["trace[1219129936] 'process raft request' (duration: 166.096786ms)","trace[1219129936] 'compare' (duration: 31.205919ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T22:42:18.145727Z","caller":"traceutil/trace.go:171","msg":"trace[2010600913] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"132.956434ms","start":"2026-04-13T22:42:18.012743Z","end":"2026-04-13T22:42:18.145699Z","steps":["trace[2010600913] 'process raft request' (duration: 132.768051ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:18.151578Z","caller":"traceutil/trace.go:171","msg":"trace[1552293748] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"109.102385ms","start":"2026-04-13T22:42:18.04246Z","end":"2026-04-13T22:42:18.151562Z","steps":["trace[1552293748] 'process raft request' (duration: 108.692769ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:21.472787Z","caller":"traceutil/trace.go:171","msg":"trace[980679568] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"123.714473ms","start":"2026-04-13T22:42:21.349007Z","end":"2026-04-13T22:42:21.472722Z","steps":["trace[980679568] 'process raft request' (duration: 123.51706ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:26.427623Z","caller":"traceutil/trace.go:171","msg":"trace[233631554] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"149.774373ms","start":"2026-04-13T22:42:26.27782Z","end":"2026-04-13T22:42:26.427594Z","steps":["trace[233631554] 'process raft request' (duration: 147.002169ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:26.427647Z","caller":"traceutil/trace.go:171","msg":"trace[718551626] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"147.67329ms","start":"2026-04-13T22:42:26.279938Z","end":"2026-04-13T22:42:26.427611Z","steps":["trace[718551626] 'process raft request' (duration: 147.594838ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:28.539118Z","caller":"traceutil/trace.go:171","msg":"trace[825631196] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"102.95859ms","start":"2026-04-13T22:42:28.436118Z","end":"2026-04-13T22:42:28.539076Z","steps":["trace[825631196] 'process raft request' (duration: 68.62046ms)","trace[825631196] 'compare' (duration: 34.157037ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T22:42:28.544792Z","caller":"traceutil/trace.go:171","msg":"trace[286390292] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"108.631591ms","start":"2026-04-13T22:42:28.436134Z","end":"2026-04-13T22:42:28.544765Z","steps":["trace[286390292] 'process raft request' (duration: 108.470578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:28.995066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.092083ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T22:42:28.995266Z","caller":"traceutil/trace.go:171","msg":"trace[1354172680] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"447.179725ms","start":"2026-04-13T22:42:28.548069Z","end":"2026-04-13T22:42:28.995249Z","steps":["trace[1354172680] 'process raft request' (duration: 447.118744ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:28.99526Z","caller":"traceutil/trace.go:171","msg":"trace[1096514133] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"451.044867ms","start":"2026-04-13T22:42:28.544184Z","end":"2026-04-13T22:42:28.995229Z","steps":["trace[1096514133] 'process raft request' (duration: 307.68384ms)","trace[1096514133] 'compare' (duration: 142.91936ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T22:42:28.995336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:28.548052Z","time spent":"447.251366ms","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T22:42:28.995435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:28.544169Z","time spent":"451.15707ms","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T22:42:28.995655Z","caller":"traceutil/trace.go:171","msg":"trace[253444608] linearizableReadLoop","detail":"{readStateIndex:798; appliedIndex:797; }","duration":"450.923965ms","start":"2026-04-13T22:42:28.54472Z","end":"2026-04-13T22:42:28.995644Z","steps":["trace[253444608] 'read index received' (duration: 307.143172ms)","trace[253444608] 'applied index is now lower than readState.Index' (duration: 143.779713ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T22:42:28.995783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.975981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-13T22:42:28.995811Z","caller":"traceutil/trace.go:171","msg":"trace[273543704] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:772; }","duration":"530.032913ms","start":"2026-04-13T22:42:28.46577Z","end":"2026-04-13T22:42:28.995803Z","steps":["trace[273543704] 'agreement among raft nodes before linearized reading' (duration: 529.910881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:28.995837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:28.465756Z","time spent":"530.075323ms","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-13T22:42:30.843212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.312849ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T22:42:30.843319Z","caller":"traceutil/trace.go:171","msg":"trace[1407433343] linearizableReadLoop","detail":"{readStateIndex:804; appliedIndex:803; }","duration":"295.047438ms","start":"2026-04-13T22:42:30.548256Z","end":"2026-04-13T22:42:30.843303Z","steps":["trace[1407433343] 'read index received' (duration: 96.509466ms)","trace[1407433343] 'applied index is now lower than readState.Index' (duration: 198.536832ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T22:42:30.843555Z","caller":"traceutil/trace.go:171","msg":"trace[1299814855] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"296.928629ms","start":"2026-04-13T22:42:30.546584Z","end":"2026-04-13T22:42:30.843512Z","steps":["trace[1299814855] 'process raft request' (duration: 98.231704ms)","trace[1299814855] 'compare' (duration: 197.958273ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T22:42:30.843892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.628947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-13T22:42:30.844017Z","caller":"traceutil/trace.go:171","msg":"trace[1457746718] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:776; }","duration":"295.76831ms","start":"2026-04-13T22:42:30.548202Z","end":"2026-04-13T22:42:30.84397Z","steps":["trace[1457746718] 'agreement among raft nodes before linearized reading' (duration: 295.278952ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:32.996975Z","caller":"traceutil/trace.go:171","msg":"trace[778568377] linearizableReadLoop","detail":"{readStateIndex:817; appliedIndex:816; }","duration":"117.463626ms","start":"2026-04-13T22:42:32.879479Z","end":"2026-04-13T22:42:32.996943Z","steps":["trace[778568377] 'read index received' (duration: 111.971877ms)","trace[778568377] 'applied index is now lower than readState.Index' (duration: 5.489589ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T22:42:32.997023Z","caller":"traceutil/trace.go:171","msg":"trace[175124007] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"140.153434ms","start":"2026-04-13T22:42:32.856844Z","end":"2026-04-13T22:42:32.996997Z","steps":["trace[175124007] 'process raft request' (duration: 134.517263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:32.997204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.684953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:1 size:4637"} {"level":"info","ts":"2026-04-13T22:42:32.997259Z","caller":"traceutil/trace.go:171","msg":"trace[799380726] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-gateway; range_end:; response_count:1; response_revision:789; }","duration":"140.786894ms","start":"2026-04-13T22:42:32.856454Z","end":"2026-04-13T22:42:32.997241Z","steps":["trace[799380726] 'agreement among raft nodes before linearized reading' (duration: 140.596131ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:32.999052Z","caller":"traceutil/trace.go:171","msg":"trace[1510880161] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"116.026232ms","start":"2026-04-13T22:42:32.883Z","end":"2026-04-13T22:42:32.999026Z","steps":["trace[1510880161] 'process raft request' (duration: 115.852189ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:33.263277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.970254ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T22:42:33.26342Z","caller":"traceutil/trace.go:171","msg":"trace[1791893401] linearizableReadLoop","detail":"{readStateIndex:820; appliedIndex:819; }","duration":"145.874474ms","start":"2026-04-13T22:42:33.117516Z","end":"2026-04-13T22:42:33.263391Z","steps":["trace[1791893401] 'read index received' (duration: 66.341µs)","trace[1791893401] 'applied index is now lower than readState.Index' (duration: 145.806443ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T22:42:33.263528Z","caller":"traceutil/trace.go:171","msg":"trace[1737981020] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"176.767927ms","start":"2026-04-13T22:42:33.08674Z","end":"2026-04-13T22:42:33.263508Z","steps":["trace[1737981020] 'process raft request' (duration: 16.440188ms)","trace[1737981020] 'compare' (duration: 159.783651ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T22:42:33.263831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.094141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T22:42:33.263903Z","caller":"traceutil/trace.go:171","msg":"trace[137783470] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:792; }","duration":"140.187692ms","start":"2026-04-13T22:42:33.1237Z","end":"2026-04-13T22:42:33.263887Z","steps":["trace[137783470] 'agreement among raft nodes before linearized reading' (duration: 140.07687ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:33.263921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.400873ms","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-13T22:42:33.263973Z","caller":"traceutil/trace.go:171","msg":"trace[1680442573] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:792; }","duration":"146.482445ms","start":"2026-04-13T22:42:33.117474Z","end":"2026-04-13T22:42:33.263957Z","steps":["trace[1680442573] 'agreement among raft nodes before linearized reading' (duration: 146.315303ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:34.569346Z","caller":"traceutil/trace.go:171","msg":"trace[660604151] linearizableReadLoop","detail":"{readStateIndex:822; appliedIndex:821; }","duration":"443.533381ms","start":"2026-04-13T22:42:34.125792Z","end":"2026-04-13T22:42:34.569326Z","steps":["trace[660604151] 'read index received' (duration: 443.378449ms)","trace[660604151] 'applied index is now lower than readState.Index' (duration: 153.972µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T22:42:34.569426Z","caller":"traceutil/trace.go:171","msg":"trace[456155108] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"563.781545ms","start":"2026-04-13T22:42:34.005612Z","end":"2026-04-13T22:42:34.569393Z","steps":["trace[456155108] 'process raft request' (duration: 563.571892ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:34.569514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.662783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T22:42:34.569548Z","caller":"traceutil/trace.go:171","msg":"trace[1366345895] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:794; }","duration":"443.782135ms","start":"2026-04-13T22:42:34.125757Z","end":"2026-04-13T22:42:34.569539Z","steps":["trace[1366345895] 'agreement among raft nodes before linearized reading' (duration: 443.674584ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:34.569617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:34.125739Z","time spent":"443.869846ms","remote":"127.0.0.1:45346","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-13T22:42:34.569614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:34.005589Z","time spent":"563.916827ms","remote":"127.0.0.1:45614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T22:42:34.573449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.803454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-13T22:42:34.573657Z","caller":"traceutil/trace.go:171","msg":"trace[1542113705] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"151.166498ms","start":"2026-04-13T22:42:34.422412Z","end":"2026-04-13T22:42:34.573579Z","steps":["trace[1542113705] 'process raft request' (duration: 150.745662ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:34.573518Z","caller":"traceutil/trace.go:171","msg":"trace[789402365] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:795; }","duration":"196.914625ms","start":"2026-04-13T22:42:34.376587Z","end":"2026-04-13T22:42:34.573501Z","steps":["trace[789402365] 'agreement among raft nodes before linearized reading' (duration: 196.748552ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:42.06543Z","caller":"traceutil/trace.go:171","msg":"trace[1967467492] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"133.23197ms","start":"2026-04-13T22:42:41.932172Z","end":"2026-04-13T22:42:42.065404Z","steps":["trace[1967467492] 'process raft request' (duration: 133.088177ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:42.250517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.907404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T22:42:42.250626Z","caller":"traceutil/trace.go:171","msg":"trace[219810608] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:874; }","duration":"122.104608ms","start":"2026-04-13T22:42:42.128488Z","end":"2026-04-13T22:42:42.250592Z","steps":["trace[219810608] 'range keys from in-memory index tree' (duration: 121.809013ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:42.758681Z","caller":"traceutil/trace.go:171","msg":"trace[1386344586] transaction","detail":"{read_only:false; response_revision:876; number_of_response:1; }","duration":"109.508157ms","start":"2026-04-13T22:42:42.649147Z","end":"2026-04-13T22:42:42.758655Z","steps":["trace[1386344586] 'process raft request' (duration: 109.293534ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:43.113355Z","caller":"traceutil/trace.go:171","msg":"trace[113430389] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"126.20585ms","start":"2026-04-13T22:42:42.987118Z","end":"2026-04-13T22:42:43.113324Z","steps":["trace[113430389] 'process raft request' (duration: 126.022047ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:44.203952Z","caller":"traceutil/trace.go:171","msg":"trace[20460379] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"284.704431ms","start":"2026-04-13T22:42:43.919226Z","end":"2026-04-13T22:42:44.203931Z","steps":["trace[20460379] 'process raft request' (duration: 245.578755ms)","trace[20460379] 'compare' (duration: 38.918252ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T22:42:44.204261Z","caller":"traceutil/trace.go:171","msg":"trace[1042150538] transaction","detail":"{read_only:false; response_revision:899; number_of_response:1; }","duration":"283.770746ms","start":"2026-04-13T22:42:43.920474Z","end":"2026-04-13T22:42:44.204244Z","steps":["trace[1042150538] 'process raft request' (duration: 283.417109ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:44.710009Z","caller":"traceutil/trace.go:171","msg":"trace[1793001152] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"170.675832ms","start":"2026-04-13T22:42:44.53931Z","end":"2026-04-13T22:42:44.709985Z","steps":["trace[1793001152] 'process raft request' (duration: 170.486719ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:47.287172Z","caller":"traceutil/trace.go:171","msg":"trace[297928585] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"153.89416ms","start":"2026-04-13T22:42:47.133253Z","end":"2026-04-13T22:42:47.287147Z","steps":["trace[297928585] 'process raft request' (duration: 153.732497ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:47.442118Z","caller":"traceutil/trace.go:171","msg":"trace[1679900648] linearizableReadLoop","detail":"{readStateIndex:953; appliedIndex:951; }","duration":"281.539555ms","start":"2026-04-13T22:42:47.160554Z","end":"2026-04-13T22:42:47.442093Z","steps":["trace[1679900648] 'read index received' (duration: 126.421365ms)","trace[1679900648] 'applied index is now lower than readState.Index' (duration: 155.11715ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T22:42:47.442242Z","caller":"traceutil/trace.go:171","msg":"trace[2006603854] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"307.608656ms","start":"2026-04-13T22:42:47.134605Z","end":"2026-04-13T22:42:47.442214Z","steps":["trace[2006603854] 'process raft request' (duration: 307.073227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:47.442292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.725829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T22:42:47.442357Z","caller":"traceutil/trace.go:171","msg":"trace[1157797523] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:0; response_revision:921; }","duration":"281.857811ms","start":"2026-04-13T22:42:47.160482Z","end":"2026-04-13T22:42:47.44234Z","steps":["trace[1157797523] 'agreement among raft nodes before linearized reading' (duration: 281.733509ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:47.442373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.548458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-13T22:42:47.442392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:47.134581Z","time spent":"307.729798ms","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T22:42:47.442791Z","caller":"traceutil/trace.go:171","msg":"trace[1386959409] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:921; }","duration":"280.617939ms","start":"2026-04-13T22:42:47.16178Z","end":"2026-04-13T22:42:47.442398Z","steps":["trace[1386959409] 'agreement among raft nodes before linearized reading' (duration: 280.466927ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:47.799143Z","caller":"traceutil/trace.go:171","msg":"trace[656009234] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"193.904255ms","start":"2026-04-13T22:42:47.605213Z","end":"2026-04-13T22:42:47.799117Z","steps":["trace[656009234] 'process raft request' (duration: 193.844224ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:47.799756Z","caller":"traceutil/trace.go:171","msg":"trace[386721927] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"196.56895ms","start":"2026-04-13T22:42:47.602571Z","end":"2026-04-13T22:42:47.79914Z","steps":["trace[386721927] 'process raft request' (duration: 189.176956ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:48.036154Z","caller":"traceutil/trace.go:171","msg":"trace[1474673085] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"194.030009ms","start":"2026-04-13T22:42:47.842096Z","end":"2026-04-13T22:42:48.036126Z","steps":["trace[1474673085] 'process raft request' (duration: 152.018637ms)","trace[1474673085] 'compare' (duration: 41.853939ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T22:42:48.181068Z","caller":"traceutil/trace.go:171","msg":"trace[700652984] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"101.515459ms","start":"2026-04-13T22:42:48.079522Z","end":"2026-04-13T22:42:48.181037Z","steps":["trace[700652984] 'process raft request' (duration: 101.104402ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:59.995438Z","caller":"traceutil/trace.go:171","msg":"trace[1215253940] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"415.492217ms","start":"2026-04-13T22:42:59.57991Z","end":"2026-04-13T22:42:59.995402Z","steps":["trace[1215253940] 'process raft request' (duration: 415.279883ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:59.995765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:59.579894Z","time spent":"415.669019ms","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T22:42:59.99624Z","caller":"traceutil/trace.go:171","msg":"trace[925953738] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"290.134415ms","start":"2026-04-13T22:42:59.706079Z","end":"2026-04-13T22:42:59.996214Z","steps":["trace[925953738] 'process raft request' (duration: 290.069134ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:42:59.996265Z","caller":"traceutil/trace.go:171","msg":"trace[541971181] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"415.532216ms","start":"2026-04-13T22:42:59.580709Z","end":"2026-04-13T22:42:59.996242Z","steps":["trace[541971181] 'process raft request' (duration: 415.327832ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:42:59.996364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T22:42:59.580692Z","time spent":"415.627739ms","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T22:43:10.129797Z","caller":"traceutil/trace.go:171","msg":"trace[280660531] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"113.940521ms","start":"2026-04-13T22:43:10.01584Z","end":"2026-04-13T22:43:10.129781Z","steps":["trace[280660531] 'process raft request' (duration: 113.839929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:43:10.145355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.4059ms","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-13T22:43:10.145429Z","caller":"traceutil/trace.go:171","msg":"trace[1399736639] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1056; }","duration":"109.521883ms","start":"2026-04-13T22:43:10.035889Z","end":"2026-04-13T22:43:10.145411Z","steps":["trace[1399736639] 'agreement among raft nodes before linearized reading' (duration: 109.315739ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:43:17.192616Z","caller":"traceutil/trace.go:171","msg":"trace[796781384] linearizableReadLoop","detail":"{readStateIndex:1136; appliedIndex:1135; }","duration":"137.214498ms","start":"2026-04-13T22:43:17.05538Z","end":"2026-04-13T22:43:17.192594Z","steps":["trace[796781384] 'read index received' (duration: 137.148367ms)","trace[796781384] 'applied index is now lower than readState.Index' (duration: 65.141µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T22:43:17.192777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.379312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T22:43:17.192819Z","caller":"traceutil/trace.go:171","msg":"trace[2054912740] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1096; }","duration":"137.474403ms","start":"2026-04-13T22:43:17.055331Z","end":"2026-04-13T22:43:17.192805Z","steps":["trace[2054912740] 'agreement among raft nodes before linearized reading' (duration: 137.365941ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:43:17.192821Z","caller":"traceutil/trace.go:171","msg":"trace[2038461445] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"211.013872ms","start":"2026-04-13T22:43:16.981717Z","end":"2026-04-13T22:43:17.192731Z","steps":["trace[2038461445] 'process raft request' (duration: 210.707396ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:43:18.409975Z","caller":"traceutil/trace.go:171","msg":"trace[491310932] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"164.356054ms","start":"2026-04-13T22:43:18.24559Z","end":"2026-04-13T22:43:18.409946Z","steps":["trace[491310932] 'process raft request' (duration: 163.955987ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:43:25.360245Z","caller":"traceutil/trace.go:171","msg":"trace[1408034855] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"132.352764ms","start":"2026-04-13T22:43:25.227866Z","end":"2026-04-13T22:43:25.360219Z","steps":["trace[1408034855] 'process raft request' (duration: 132.213402ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:43:41.343798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.831553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:node\" ","response":"range_response_count:1 size:603"} {"level":"warn","ts":"2026-04-13T22:43:41.343906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.924656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:monitoring\" ","response":"range_response_count:1 size:694"} {"level":"info","ts":"2026-04-13T22:43:41.344029Z","caller":"traceutil/trace.go:171","msg":"trace[223951480] range","detail":"{range_begin:/registry/clusterrolebindings/system:monitoring; range_end:; response_count:1; response_revision:1185; }","duration":"109.062539ms","start":"2026-04-13T22:43:41.23493Z","end":"2026-04-13T22:43:41.343992Z","steps":["trace[223951480] 'range keys from in-memory index tree' (duration: 108.828075ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:43:41.344257Z","caller":"traceutil/trace.go:171","msg":"trace[474196678] range","detail":"{range_begin:/registry/clusterrolebindings/system:node; range_end:; response_count:1; response_revision:1185; }","duration":"110.048816ms","start":"2026-04-13T22:43:41.233916Z","end":"2026-04-13T22:43:41.343965Z","steps":["trace[474196678] 'range keys from in-memory index tree' (duration: 109.774442ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:43:41.877256Z","caller":"traceutil/trace.go:171","msg":"trace[400950428] linearizableReadLoop","detail":"{readStateIndex:1232; appliedIndex:1231; }","duration":"269.879664ms","start":"2026-04-13T22:43:41.607351Z","end":"2026-04-13T22:43:41.877231Z","steps":["trace[400950428] 'read index received' (duration: 269.67252ms)","trace[400950428] 'applied index is now lower than readState.Index' (duration: 206.054µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T22:43:41.877663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.721574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:service-account-issuer-discovery\" ","response":"range_response_count:1 size:765"} {"level":"info","ts":"2026-04-13T22:43:41.877683Z","caller":"traceutil/trace.go:171","msg":"trace[912646676] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"274.080971ms","start":"2026-04-13T22:43:41.603577Z","end":"2026-04-13T22:43:41.877658Z","steps":["trace[912646676] 'process raft request' (duration: 273.521822ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:43:41.87769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.311682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:volume-scheduler\" ","response":"range_response_count:1 size:723"} {"level":"info","ts":"2026-04-13T22:43:41.877749Z","caller":"traceutil/trace.go:171","msg":"trace[2040736104] range","detail":"{range_begin:/registry/clusterrolebindings/system:service-account-issuer-discovery; range_end:; response_count:1; response_revision:1187; }","duration":"267.837577ms","start":"2026-04-13T22:43:41.609888Z","end":"2026-04-13T22:43:41.877726Z","steps":["trace[2040736104] 'agreement among raft nodes before linearized reading' (duration: 267.655213ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:43:41.877805Z","caller":"traceutil/trace.go:171","msg":"trace[728543394] range","detail":"{range_begin:/registry/clusterroles/system:volume-scheduler; range_end:; response_count:1; response_revision:1187; }","duration":"270.439084ms","start":"2026-04-13T22:43:41.607315Z","end":"2026-04-13T22:43:41.877754Z","steps":["trace[728543394] 'agreement among raft nodes before linearized reading' (duration: 270.279691ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:43:41.877933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.648759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-13T22:43:41.878009Z","caller":"traceutil/trace.go:171","msg":"trace[230028668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1187; }","duration":"103.74214ms","start":"2026-04-13T22:43:41.774248Z","end":"2026-04-13T22:43:41.87799Z","steps":["trace[230028668] 'agreement among raft nodes before linearized reading' (duration: 103.405804ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:43:42.067219Z","caller":"traceutil/trace.go:171","msg":"trace[1618812941] linearizableReadLoop","detail":"{readStateIndex:1234; appliedIndex:1233; }","duration":"107.933107ms","start":"2026-04-13T22:43:41.959261Z","end":"2026-04-13T22:43:42.067195Z","steps":["trace[1618812941] 'read index received' (duration: 62.659248ms)","trace[1618812941] 'applied index is now lower than readState.Index' (duration: 45.272929ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T22:43:42.06743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.712228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:volume-scheduler\" ","response":"range_response_count:1 size:723"} {"level":"info","ts":"2026-04-13T22:43:42.067465Z","caller":"traceutil/trace.go:171","msg":"trace[2003101291] range","detail":"{range_begin:/registry/clusterroles/system:volume-scheduler; range_end:; response_count:1; response_revision:1189; }","duration":"104.80774ms","start":"2026-04-13T22:43:41.962648Z","end":"2026-04-13T22:43:42.067455Z","steps":["trace[2003101291] 'agreement among raft nodes before linearized reading' (duration: 104.720447ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T22:43:42.067483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.199743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:service-account-issuer-discovery\" ","response":"range_response_count:1 size:765"} {"level":"info","ts":"2026-04-13T22:43:42.067598Z","caller":"traceutil/trace.go:171","msg":"trace[109559702] range","detail":"{range_begin:/registry/clusterrolebindings/system:service-account-issuer-discovery; range_end:; response_count:1; response_revision:1189; }","duration":"108.313915ms","start":"2026-04-13T22:43:41.95925Z","end":"2026-04-13T22:43:42.067564Z","steps":["trace[109559702] 'agreement among raft nodes before linearized reading' (duration: 108.10662ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T22:43:42.067491Z","caller":"traceutil/trace.go:171","msg":"trace[1614263939] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"184.636983ms","start":"2026-04-13T22:43:41.882826Z","end":"2026-04-13T22:43:42.067463Z","steps":["trace[1614263939] 'process raft request' (duration: 139.080198ms)","trace[1614263939] 'compare' (duration: 45.186348ms)"],"step_count":2}