{"level":"warn","ts":"2026-02-25T02:12:24.137252Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-25T02:12:24.137337Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.155: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.155:2380","--initial-cluster=instance=https://199.204.45.155:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.155:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.155: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-02-25T02:12:24.137391Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-25T02:12:24.137399Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.155:2380"]} {"level":"info","ts":"2026-02-25T02:12:24.137421Z","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-02-25T02:12:24.137955Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.155:2379"]} {"level":"info","ts":"2026-02-25T02:12:24.138041Z","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":16,"max-cpu-available":16,"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.155:2380"],"listen-peer-urls":["https://199.204.45.155:2380"],"advertise-client-urls":["https://199.204.45.155:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.155:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.155: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-02-25T02:12:24.144094Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.853697ms"} {"level":"info","ts":"2026-02-25T02:12:24.159578Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"344940fc142d902f","cluster-id":"c7d65bf2a36fbd4"} {"level":"info","ts":"2026-02-25T02:12:24.159682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f switched to configuration voters=()"} {"level":"info","ts":"2026-02-25T02:12:24.159703Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became follower at term 0"} {"level":"info","ts":"2026-02-25T02:12:24.159713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 344940fc142d902f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-25T02:12:24.159722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became follower at term 1"} {"level":"info","ts":"2026-02-25T02:12:24.159753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f switched to configuration voters=(3767614014686597167)"} {"level":"warn","ts":"2026-02-25T02:12:24.185927Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-25T02:12:24.189588Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-25T02:12:24.191053Z","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-02-25T02:12:24.19339Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"344940fc142d902f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-25T02:12:24.193498Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"344940fc142d902f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-25T02:12:24.193639Z","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-02-25T02:12:24.193854Z","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-02-25T02:12:24.193911Z","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-02-25T02:12:24.194631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f switched to configuration voters=(3767614014686597167)"} {"level":"info","ts":"2026-02-25T02:12:24.194882Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c7d65bf2a36fbd4","local-member-id":"344940fc142d902f","added-peer-id":"344940fc142d902f","added-peer-peer-urls":["https://199.204.45.155:2380"]} {"level":"info","ts":"2026-02-25T02:12:24.196127Z","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-02-25T02:12:24.196314Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"344940fc142d902f","initial-advertise-peer-urls":["https://199.204.45.155:2380"],"listen-peer-urls":["https://199.204.45.155:2380"],"advertise-client-urls":["https://199.204.45.155:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.155:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-25T02:12:24.196368Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-25T02:12:24.196454Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.155:2380"} {"level":"info","ts":"2026-02-25T02:12:24.198432Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.155:2380"} {"level":"info","ts":"2026-02-25T02:12:24.360328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f is starting a new election at term 1"} {"level":"info","ts":"2026-02-25T02:12:24.360373Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became pre-candidate at term 1"} {"level":"info","ts":"2026-02-25T02:12:24.360406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f received MsgPreVoteResp from 344940fc142d902f at term 1"} {"level":"info","ts":"2026-02-25T02:12:24.360425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became candidate at term 2"} {"level":"info","ts":"2026-02-25T02:12:24.360436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f received MsgVoteResp from 344940fc142d902f at term 2"} {"level":"info","ts":"2026-02-25T02:12:24.360452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became leader at term 2"} {"level":"info","ts":"2026-02-25T02:12:24.360472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 344940fc142d902f elected leader 344940fc142d902f at term 2"} {"level":"info","ts":"2026-02-25T02:12:24.36132Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T02:12:24.362378Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"344940fc142d902f","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.155:2379]}","request-path":"/0/members/344940fc142d902f/attributes","cluster-id":"c7d65bf2a36fbd4","publish-timeout":"7s"} {"level":"info","ts":"2026-02-25T02:12:24.362393Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T02:12:24.362437Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T02:12:24.36268Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-25T02:12:24.3627Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-25T02:12:24.365855Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-25T02:12:24.366425Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.155:2379"} {"level":"info","ts":"2026-02-25T02:12:24.376712Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c7d65bf2a36fbd4","local-member-id":"344940fc142d902f","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T02:12:24.376813Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T02:12:24.376842Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T02:12:29.662272Z","caller":"traceutil/trace.go:171","msg":"trace[1497646586] linearizableReadLoop","detail":"{readStateIndex:227; appliedIndex:226; }","duration":"166.402353ms","start":"2026-02-25T02:12:29.495846Z","end":"2026-02-25T02:12:29.662248Z","steps":["trace[1497646586] 'read index received' (duration: 166.351712ms)","trace[1497646586] 'applied index is now lower than readState.Index' (duration: 49.711µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:12:29.662405Z","caller":"traceutil/trace.go:171","msg":"trace[674218181] transaction","detail":"{read_only:false; response_revision:222; number_of_response:1; }","duration":"247.889661ms","start":"2026-02-25T02:12:29.414461Z","end":"2026-02-25T02:12:29.66235Z","steps":["trace[674218181] 'process raft request' (duration: 247.642836ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:29.662464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.594577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-02-25T02:12:29.662529Z","caller":"traceutil/trace.go:171","msg":"trace[715201234] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:222; }","duration":"166.71132ms","start":"2026-02-25T02:12:29.495805Z","end":"2026-02-25T02:12:29.662517Z","steps":["trace[715201234] 'agreement among raft nodes before linearized reading' (duration: 166.573207ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:29.723338Z","caller":"traceutil/trace.go:171","msg":"trace[1320072046] transaction","detail":"{read_only:false; number_of_response:0; response_revision:222; }","duration":"126.064171ms","start":"2026-02-25T02:12:29.597251Z","end":"2026-02-25T02:12:29.723315Z","steps":["trace[1320072046] 'process raft request' (duration: 125.931928ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:29.723465Z","caller":"traceutil/trace.go:171","msg":"trace[801598056] transaction","detail":"{read_only:false; response_revision:223; number_of_response:1; }","duration":"107.374083ms","start":"2026-02-25T02:12:29.616032Z","end":"2026-02-25T02:12:29.723406Z","steps":["trace[801598056] 'process raft request' (duration: 107.200389ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:29.723492Z","caller":"traceutil/trace.go:171","msg":"trace[634801800] transaction","detail":"{read_only:false; number_of_response:0; response_revision:223; }","duration":"107.187109ms","start":"2026-02-25T02:12:29.616269Z","end":"2026-02-25T02:12:29.723456Z","steps":["trace[634801800] 'process raft request' (duration: 107.021095ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:29.723585Z","caller":"traceutil/trace.go:171","msg":"trace[1369214340] transaction","detail":"{read_only:false; response_revision:225; number_of_response:1; }","duration":"105.347468ms","start":"2026-02-25T02:12:29.618218Z","end":"2026-02-25T02:12:29.723566Z","steps":["trace[1369214340] 'process raft request' (duration: 105.156534ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:29.723603Z","caller":"traceutil/trace.go:171","msg":"trace[2016007001] transaction","detail":"{read_only:false; number_of_response:0; response_revision:223; }","duration":"106.705109ms","start":"2026-02-25T02:12:29.616863Z","end":"2026-02-25T02:12:29.723568Z","steps":["trace[2016007001] 'process raft request' (duration: 106.450594ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:29.723522Z","caller":"traceutil/trace.go:171","msg":"trace[56227025] transaction","detail":"{read_only:false; response_revision:224; number_of_response:1; }","duration":"106.519125ms","start":"2026-02-25T02:12:29.616964Z","end":"2026-02-25T02:12:29.723483Z","steps":["trace[56227025] 'process raft request' (duration: 106.376022ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:29.723681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.694389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:12:29.723754Z","caller":"traceutil/trace.go:171","msg":"trace[1699143010] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:225; }","duration":"227.791823ms","start":"2026-02-25T02:12:29.495946Z","end":"2026-02-25T02:12:29.723738Z","steps":["trace[1699143010] 'agreement among raft nodes before linearized reading' (duration: 227.619788ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:35.391923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.026347ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T02:12:35.392086Z","caller":"traceutil/trace.go:171","msg":"trace[1238548713] linearizableReadLoop","detail":"{readStateIndex:314; appliedIndex:313; }","duration":"646.706867ms","start":"2026-02-25T02:12:34.745359Z","end":"2026-02-25T02:12:35.392066Z","steps":["trace[1238548713] 'read index received' (duration: 73.784171ms)","trace[1238548713] 'applied index is now lower than readState.Index' (duration: 572.920896ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:12:35.392206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.85142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-25T02:12:35.392243Z","caller":"traceutil/trace.go:171","msg":"trace[991541052] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:301; }","duration":"646.921232ms","start":"2026-02-25T02:12:34.745312Z","end":"2026-02-25T02:12:35.392233Z","steps":["trace[991541052] 'agreement among raft nodes before linearized reading' (duration: 646.84565ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:35.392286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:12:34.745297Z","time spent":"646.980023ms","remote":"127.0.0.1:60986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"info","ts":"2026-02-25T02:12:35.392281Z","caller":"traceutil/trace.go:171","msg":"trace[166970957] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"677.959988ms","start":"2026-02-25T02:12:34.714114Z","end":"2026-02-25T02:12:35.392074Z","steps":["trace[166970957] 'process raft request' (duration: 105.047822ms)","trace[166970957] 'compare' (duration: 571.850754ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:12:35.3925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:12:34.71409Z","time spent":"678.295156ms","remote":"127.0.0.1:32816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T02:12:35.392553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.150405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"warn","ts":"2026-02-25T02:12:35.392551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.383556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-25T02:12:35.392716Z","caller":"traceutil/trace.go:171","msg":"trace[116452468] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:301; }","duration":"422.392531ms","start":"2026-02-25T02:12:34.97029Z","end":"2026-02-25T02:12:35.392682Z","steps":["trace[116452468] 'agreement among raft nodes before linearized reading' (duration: 422.101884ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:35.392811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.31256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-02-25T02:12:35.392773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:12:34.970276Z","time spent":"422.481262ms","remote":"127.0.0.1:60986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":225,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-02-25T02:12:35.393233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.230621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-25T02:12:35.393291Z","caller":"traceutil/trace.go:171","msg":"trace[1122007492] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:301; }","duration":"222.313782ms","start":"2026-02-25T02:12:35.170961Z","end":"2026-02-25T02:12:35.393275Z","steps":["trace[1122007492] 'agreement among raft nodes before linearized reading' (duration: 221.76598ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:35.392889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.686673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-02-25T02:12:35.393519Z","caller":"traceutil/trace.go:171","msg":"trace[376612832] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:301; }","duration":"323.308487ms","start":"2026-02-25T02:12:35.070171Z","end":"2026-02-25T02:12:35.39348Z","steps":["trace[376612832] 'agreement among raft nodes before linearized reading' (duration: 322.498369ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:35.392893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.30233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"warn","ts":"2026-02-25T02:12:35.39359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:12:35.07011Z","time spent":"323.465061ms","remote":"127.0.0.1:60986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"info","ts":"2026-02-25T02:12:35.393661Z","caller":"traceutil/trace.go:171","msg":"trace[977750577] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:301; }","duration":"616.063387ms","start":"2026-02-25T02:12:34.777538Z","end":"2026-02-25T02:12:35.393601Z","steps":["trace[977750577] 'agreement among raft nodes before linearized reading' (duration: 615.24404ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:35.392938Z","caller":"traceutil/trace.go:171","msg":"trace[439710647] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:301; }","duration":"522.495394ms","start":"2026-02-25T02:12:34.870411Z","end":"2026-02-25T02:12:35.392906Z","steps":["trace[439710647] 'agreement among raft nodes before linearized reading' (duration: 522.27726ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:35.393792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:12:34.777507Z","time spent":"616.244401ms","remote":"127.0.0.1:60986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":256,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-02-25T02:12:35.393808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:12:34.870388Z","time spent":"523.383455ms","remote":"127.0.0.1:60986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"warn","ts":"2026-02-25T02:12:35.392878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.708352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-02-25T02:12:35.393891Z","caller":"traceutil/trace.go:171","msg":"trace[1551551793] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:301; }","duration":"273.775657ms","start":"2026-02-25T02:12:35.120086Z","end":"2026-02-25T02:12:35.393861Z","steps":["trace[1551551793] 'agreement among raft nodes before linearized reading' (duration: 272.5711ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:35.392844Z","caller":"traceutil/trace.go:171","msg":"trace[954314348] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:301; }","duration":"617.684043ms","start":"2026-02-25T02:12:34.77507Z","end":"2026-02-25T02:12:35.392754Z","steps":["trace[954314348] 'agreement among raft nodes before linearized reading' (duration: 617.290735ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:35.394094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:12:34.775052Z","time spent":"619.018042ms","remote":"127.0.0.1:60986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"warn","ts":"2026-02-25T02:12:35.393007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.43893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-02-25T02:12:35.39417Z","caller":"traceutil/trace.go:171","msg":"trace[2073386629] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:301; }","duration":"373.652587ms","start":"2026-02-25T02:12:35.0205Z","end":"2026-02-25T02:12:35.394153Z","steps":["trace[2073386629] 'agreement among raft nodes before linearized reading' (duration: 372.256606ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:35.394233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:12:35.020486Z","time spent":"373.731598ms","remote":"127.0.0.1:60986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":219,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"warn","ts":"2026-02-25T02:12:35.393036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.808874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-02-25T02:12:35.394419Z","caller":"traceutil/trace.go:171","msg":"trace[2019326479] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:301; }","duration":"574.216674ms","start":"2026-02-25T02:12:34.820183Z","end":"2026-02-25T02:12:35.3944Z","steps":["trace[2019326479] 'agreement among raft nodes before linearized reading' (duration: 572.604859ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:35.394471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:12:34.820173Z","time spent":"574.285066ms","remote":"127.0.0.1:60986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-02-25T02:12:35.393135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.756599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-02-25T02:12:35.394602Z","caller":"traceutil/trace.go:171","msg":"trace[776138062] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:301; }","duration":"474.269992ms","start":"2026-02-25T02:12:34.920318Z","end":"2026-02-25T02:12:35.394588Z","steps":["trace[776138062] 'agreement among raft nodes before linearized reading' (duration: 472.434932ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:35.394653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:12:34.920305Z","time spent":"474.333103ms","remote":"127.0.0.1:60986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":240,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-02-25T02:12:40.807285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.062492ms","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-02-25T02:12:40.807376Z","caller":"traceutil/trace.go:171","msg":"trace[942138914] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:368; }","duration":"225.216286ms","start":"2026-02-25T02:12:40.582146Z","end":"2026-02-25T02:12:40.807363Z","steps":["trace[942138914] 'range keys from in-memory index tree' (duration: 224.900579ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:40.807284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.237167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4260"} {"level":"info","ts":"2026-02-25T02:12:40.807588Z","caller":"traceutil/trace.go:171","msg":"trace[1773861720] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:368; }","duration":"105.527383ms","start":"2026-02-25T02:12:40.701985Z","end":"2026-02-25T02:12:40.807513Z","steps":["trace[1773861720] 'range keys from in-memory index tree' (duration: 105.123346ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:54.974211Z","caller":"traceutil/trace.go:171","msg":"trace[7982212] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"102.151109ms","start":"2026-02-25T02:12:54.872032Z","end":"2026-02-25T02:12:54.974183Z","steps":["trace[7982212] 'process raft request' (duration: 101.976326ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:56.530152Z","caller":"traceutil/trace.go:171","msg":"trace[1017349953] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"103.81258ms","start":"2026-02-25T02:12:56.42631Z","end":"2026-02-25T02:12:56.530123Z","steps":["trace[1017349953] 'process raft request' (duration: 103.638795ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:56.796073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.479022ms","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-02-25T02:12:56.796148Z","caller":"traceutil/trace.go:171","msg":"trace[1472235390] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:472; }","duration":"229.601526ms","start":"2026-02-25T02:12:56.566528Z","end":"2026-02-25T02:12:56.796129Z","steps":["trace[1472235390] 'range keys from in-memory index tree' (duration: 229.316329ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:57.013566Z","caller":"traceutil/trace.go:171","msg":"trace[651594709] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"213.431972ms","start":"2026-02-25T02:12:56.800098Z","end":"2026-02-25T02:12:57.013529Z","steps":["trace[651594709] 'process raft request' (duration: 213.098444ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:58.71656Z","caller":"traceutil/trace.go:171","msg":"trace[103180927] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"174.443471ms","start":"2026-02-25T02:12:58.542061Z","end":"2026-02-25T02:12:58.716505Z","steps":["trace[103180927] 'process raft request' (duration: 174.302728ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:58.844916Z","caller":"traceutil/trace.go:171","msg":"trace[475564322] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"297.518902ms","start":"2026-02-25T02:12:58.547374Z","end":"2026-02-25T02:12:58.844893Z","steps":["trace[475564322] 'process raft request' (duration: 297.480101ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:12:58.844973Z","caller":"traceutil/trace.go:171","msg":"trace[1509075603] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"301.768961ms","start":"2026-02-25T02:12:58.543181Z","end":"2026-02-25T02:12:58.84495Z","steps":["trace[1509075603] 'process raft request' (duration: 301.618607ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:58.845084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:12:58.543175Z","time spent":"301.841103ms","remote":"127.0.0.1:60986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":178,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T02:12:58.845095Z","caller":"traceutil/trace.go:171","msg":"trace[2049133521] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"302.320723ms","start":"2026-02-25T02:12:58.542744Z","end":"2026-02-25T02:12:58.845065Z","steps":["trace[2049133521] 'process raft request' (duration: 301.910744ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:12:58.845455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:12:58.542732Z","time spent":"302.425526ms","remote":"127.0.0.1:60874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1745,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T02:13:02.183801Z","caller":"traceutil/trace.go:171","msg":"trace[630574497] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"552.221132ms","start":"2026-02-25T02:13:01.631549Z","end":"2026-02-25T02:13:02.18377Z","steps":["trace[630574497] 'process raft request' (duration: 545.840803ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:13:02.183999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:01.631529Z","time spent":"552.372796ms","remote":"127.0.0.1:60964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T02:13:03.482216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.380885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:13:03.482291Z","caller":"traceutil/trace.go:171","msg":"trace[1653991556] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:512; }","duration":"530.488708ms","start":"2026-02-25T02:13:02.951783Z","end":"2026-02-25T02:13:03.482272Z","steps":["trace[1653991556] 'range keys from in-memory index tree' (duration: 530.307724ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:13:03.482301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.681942ms","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-02-25T02:13:03.482325Z","caller":"traceutil/trace.go:171","msg":"trace[2028686211] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:512; }","duration":"403.729752ms","start":"2026-02-25T02:13:03.078588Z","end":"2026-02-25T02:13:03.482318Z","steps":["trace[2028686211] 'range keys from in-memory index tree' (duration: 403.579978ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:13:03.48232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.046326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-25T02:13:03.482328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:02.951758Z","time spent":"530.56234ms","remote":"127.0.0.1:60798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-25T02:13:03.482341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:03.078575Z","time spent":"403.762132ms","remote":"127.0.0.1:32816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-25T02:13:03.482353Z","caller":"traceutil/trace.go:171","msg":"trace[540145782] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:512; }","duration":"441.119388ms","start":"2026-02-25T02:13:03.041223Z","end":"2026-02-25T02:13:03.482342Z","steps":["trace[540145782] 'range keys from in-memory index tree' (duration: 440.932264ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:13:03.482392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:03.041202Z","time spent":"441.18307ms","remote":"127.0.0.1:32816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-25T02:13:03.482214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"861.090607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/cert-manager/\" range_end:\"/registry/secrets/cert-manager0\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T02:13:03.482436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"753.820322ms","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-02-25T02:13:03.482479Z","caller":"traceutil/trace.go:171","msg":"trace[677598540] range","detail":"{range_begin:/registry/secrets/cert-manager/; range_end:/registry/secrets/cert-manager0; response_count:0; response_revision:512; }","duration":"861.369963ms","start":"2026-02-25T02:13:02.62107Z","end":"2026-02-25T02:13:03.48244Z","steps":["trace[677598540] 'range keys from in-memory index tree' (duration: 860.989305ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:13:03.482573Z","caller":"traceutil/trace.go:171","msg":"trace[352362035] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:512; }","duration":"753.972726ms","start":"2026-02-25T02:13:02.728549Z","end":"2026-02-25T02:13:03.482521Z","steps":["trace[352362035] 'range keys from in-memory index tree' (duration: 753.596117ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:13:03.482609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:02.621053Z","time spent":"861.511527ms","remote":"127.0.0.1:60860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/cert-manager/\" range_end:\"/registry/secrets/cert-manager0\" "} {"level":"warn","ts":"2026-02-25T02:13:03.48262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:02.728503Z","time spent":"754.105299ms","remote":"127.0.0.1:32816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-25T02:13:03.984018Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389695018689618794,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-25T02:13:04.381513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.216501ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-25T02:13:04.387331Z","caller":"traceutil/trace.go:171","msg":"trace[1473041704] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"900.291275ms","start":"2026-02-25T02:13:03.487014Z","end":"2026-02-25T02:13:04.387305Z","steps":["trace[1473041704] 'process raft request' (duration: 900.09283ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:13:04.387487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:03.486982Z","time spent":"900.425997ms","remote":"127.0.0.1:32816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T02:13:04.387685Z","caller":"traceutil/trace.go:171","msg":"trace[2054477790] linearizableReadLoop","detail":"{readStateIndex:535; appliedIndex:531; }","duration":"904.194765ms","start":"2026-02-25T02:13:03.483468Z","end":"2026-02-25T02:13:04.387663Z","steps":["trace[2054477790] 'read index received' (duration: 737.818821ms)","trace[2054477790] 'applied index is now lower than readState.Index' (duration: 166.374854ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:13:04.387697Z","caller":"traceutil/trace.go:171","msg":"trace[1475597920] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"896.834054ms","start":"2026-02-25T02:13:03.49084Z","end":"2026-02-25T02:13:04.387674Z","steps":["trace[1475597920] 'process raft request' (duration: 896.620049ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:13:04.387764Z","caller":"traceutil/trace.go:171","msg":"trace[734633529] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"900.279174ms","start":"2026-02-25T02:13:03.487348Z","end":"2026-02-25T02:13:04.387628Z","steps":["trace[734633529] 'process raft request' (duration: 899.910366ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:13:04.387882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:03.490813Z","time spent":"896.955697ms","remote":"127.0.0.1:32816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T02:13:04.387878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.361199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T02:13:04.387902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.220045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/cert-manager/\" range_end:\"/registry/secrets/cert-manager0\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T02:13:04.387947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:03.487332Z","time spent":"900.519989ms","remote":"127.0.0.1:32816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T02:13:04.387977Z","caller":"traceutil/trace.go:171","msg":"trace[1961663299] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:515; }","duration":"904.511573ms","start":"2026-02-25T02:13:03.48344Z","end":"2026-02-25T02:13:04.387952Z","steps":["trace[1961663299] 'agreement among raft nodes before linearized reading' (duration: 904.294067ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:13:04.388013Z","caller":"traceutil/trace.go:171","msg":"trace[432324479] range","detail":"{range_begin:/registry/secrets/cert-manager/; range_end:/registry/secrets/cert-manager0; response_count:0; response_revision:515; }","duration":"117.336268ms","start":"2026-02-25T02:13:04.270648Z","end":"2026-02-25T02:13:04.387984Z","steps":["trace[432324479] 'agreement among raft nodes before linearized reading' (duration: 117.167454ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:13:04.388028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:03.483421Z","time spent":"904.598685ms","remote":"127.0.0.1:60776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-25T02:13:04.388055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.807711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-25T02:13:04.388168Z","caller":"traceutil/trace.go:171","msg":"trace[857342233] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:515; }","duration":"765.952653ms","start":"2026-02-25T02:13:03.622201Z","end":"2026-02-25T02:13:04.388153Z","steps":["trace[857342233] 'agreement among raft nodes before linearized reading' (duration: 765.589704ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:13:04.388249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:03.622188Z","time spent":"766.049336ms","remote":"127.0.0.1:32816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-25T02:13:06.230333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.503804ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-25T02:13:06.23047Z","caller":"traceutil/trace.go:171","msg":"trace[949310714] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"278.511051ms","start":"2026-02-25T02:13:05.95194Z","end":"2026-02-25T02:13:06.230451Z","steps":["trace[949310714] 'read index received' (duration: 52.481µs)","trace[949310714] 'applied index is now lower than readState.Index' (duration: 278.45706ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:13:06.230591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.643954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:13:06.230639Z","caller":"traceutil/trace.go:171","msg":"trace[1340947990] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"278.736627ms","start":"2026-02-25T02:13:05.95189Z","end":"2026-02-25T02:13:06.230626Z","steps":["trace[1340947990] 'agreement among raft nodes before linearized reading' (duration: 278.621484ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:13:06.230636Z","caller":"traceutil/trace.go:171","msg":"trace[1299488354] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"485.847024ms","start":"2026-02-25T02:13:05.744757Z","end":"2026-02-25T02:13:06.230604Z","steps":["trace[1299488354] 'process raft request' (duration: 123.996992ms)","trace[1299488354] 'compare' (duration: 361.30573ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:13:06.230727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:05.744724Z","time spent":"485.960607ms","remote":"127.0.0.1:32850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1243,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T02:13:20.9984Z","caller":"traceutil/trace.go:171","msg":"trace[1583632982] transaction","detail":"{read_only:false; response_revision:859; number_of_response:1; }","duration":"247.209586ms","start":"2026-02-25T02:13:20.751165Z","end":"2026-02-25T02:13:20.998374Z","steps":["trace[1583632982] 'process raft request' (duration: 247.037123ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:13:21.072956Z","caller":"traceutil/trace.go:171","msg":"trace[1229582569] linearizableReadLoop","detail":"{readStateIndex:884; appliedIndex:882; }","duration":"121.623898ms","start":"2026-02-25T02:13:20.951299Z","end":"2026-02-25T02:13:21.072923Z","steps":["trace[1229582569] 'read index received' (duration: 46.882136ms)","trace[1229582569] 'applied index is now lower than readState.Index' (duration: 74.740452ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:13:21.07312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.801983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:13:21.073072Z","caller":"traceutil/trace.go:171","msg":"trace[1843497951] transaction","detail":"{read_only:false; response_revision:860; number_of_response:1; }","duration":"246.177413ms","start":"2026-02-25T02:13:20.826826Z","end":"2026-02-25T02:13:21.073003Z","steps":["trace[1843497951] 'process raft request' (duration: 245.951346ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:13:21.073171Z","caller":"traceutil/trace.go:171","msg":"trace[2029456873] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:860; }","duration":"121.918805ms","start":"2026-02-25T02:13:20.951238Z","end":"2026-02-25T02:13:21.073157Z","steps":["trace[2029456873] 'agreement among raft nodes before linearized reading' (duration: 121.818533ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:13:22.739204Z","caller":"traceutil/trace.go:171","msg":"trace[138716894] linearizableReadLoop","detail":"{readStateIndex:890; appliedIndex:889; }","duration":"278.534242ms","start":"2026-02-25T02:13:22.46065Z","end":"2026-02-25T02:13:22.739184Z","steps":["trace[138716894] 'read index received' (duration: 278.367668ms)","trace[138716894] 'applied index is now lower than readState.Index' (duration: 165.724µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:13:22.739369Z","caller":"traceutil/trace.go:171","msg":"trace[523627498] transaction","detail":"{read_only:false; response_revision:866; number_of_response:1; }","duration":"552.219092ms","start":"2026-02-25T02:13:22.187115Z","end":"2026-02-25T02:13:22.739334Z","steps":["trace[523627498] 'process raft request' (duration: 551.956886ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:13:22.739466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.807108ms","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-02-25T02:13:22.739505Z","caller":"traceutil/trace.go:171","msg":"trace[781807541] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:866; }","duration":"278.915151ms","start":"2026-02-25T02:13:22.460577Z","end":"2026-02-25T02:13:22.739492Z","steps":["trace[781807541] 'agreement among raft nodes before linearized reading' (duration: 278.713726ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:13:22.73951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:22.187087Z","time spent":"552.356806ms","remote":"127.0.0.1:32816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":513,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T02:13:22.739592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.652255ms","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-02-25T02:13:22.739665Z","caller":"traceutil/trace.go:171","msg":"trace[1166899357] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:866; }","duration":"278.784057ms","start":"2026-02-25T02:13:22.460863Z","end":"2026-02-25T02:13:22.739647Z","steps":["trace[1166899357] 'agreement among raft nodes before linearized reading' (duration: 278.559102ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:13:22.739669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.012793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-02-25T02:13:22.739757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.162224ms","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-02-25T02:13:22.739768Z","caller":"traceutil/trace.go:171","msg":"trace[1329313332] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:866; }","duration":"238.145527ms","start":"2026-02-25T02:13:22.5016Z","end":"2026-02-25T02:13:22.739745Z","steps":["trace[1329313332] 'agreement among raft nodes before linearized reading' (duration: 237.87842ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:13:22.739793Z","caller":"traceutil/trace.go:171","msg":"trace[195646926] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:866; }","duration":"243.273075ms","start":"2026-02-25T02:13:22.49651Z","end":"2026-02-25T02:13:22.739783Z","steps":["trace[195646926] 'agreement among raft nodes before linearized reading' (duration: 243.117711ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:13:22.739895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.242943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-25T02:13:22.740196Z","caller":"traceutil/trace.go:171","msg":"trace[539614442] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:866; }","duration":"217.58821ms","start":"2026-02-25T02:13:22.522588Z","end":"2026-02-25T02:13:22.740176Z","steps":["trace[539614442] 'agreement among raft nodes before linearized reading' (duration: 217.11459ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:13:22.964219Z","caller":"traceutil/trace.go:171","msg":"trace[975135329] transaction","detail":"{read_only:false; response_revision:867; number_of_response:1; }","duration":"220.713494ms","start":"2026-02-25T02:13:22.74347Z","end":"2026-02-25T02:13:22.964184Z","steps":["trace[975135329] 'process raft request' (duration: 193.187185ms)","trace[975135329] 'compare' (duration: 27.244642ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:13:22.993108Z","caller":"traceutil/trace.go:171","msg":"trace[2105510657] transaction","detail":"{read_only:false; response_revision:868; number_of_response:1; }","duration":"249.51016ms","start":"2026-02-25T02:13:22.743585Z","end":"2026-02-25T02:13:22.993096Z","steps":["trace[2105510657] 'process raft request' (duration: 249.401777ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:13:22.993246Z","caller":"traceutil/trace.go:171","msg":"trace[944179045] transaction","detail":"{read_only:false; response_revision:869; number_of_response:1; }","duration":"249.033549ms","start":"2026-02-25T02:13:22.744205Z","end":"2026-02-25T02:13:22.993239Z","steps":["trace[944179045] 'process raft request' (duration: 248.866385ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:13:22.993562Z","caller":"traceutil/trace.go:171","msg":"trace[131516850] transaction","detail":"{read_only:false; response_revision:872; number_of_response:1; }","duration":"248.952517ms","start":"2026-02-25T02:13:22.744598Z","end":"2026-02-25T02:13:22.99355Z","steps":["trace[131516850] 'process raft request' (duration: 248.885506ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:13:22.993552Z","caller":"traceutil/trace.go:171","msg":"trace[967988417] transaction","detail":"{read_only:false; response_revision:870; number_of_response:1; }","duration":"249.263464ms","start":"2026-02-25T02:13:22.744269Z","end":"2026-02-25T02:13:22.993532Z","steps":["trace[967988417] 'process raft request' (duration: 248.945757ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:13:22.993621Z","caller":"traceutil/trace.go:171","msg":"trace[408300536] transaction","detail":"{read_only:false; response_revision:871; number_of_response:1; }","duration":"249.08758ms","start":"2026-02-25T02:13:22.7445Z","end":"2026-02-25T02:13:22.993588Z","steps":["trace[408300536] 'process raft request' (duration: 248.903866ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:13:23.088646Z","caller":"traceutil/trace.go:171","msg":"trace[1816079678] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"117.83419ms","start":"2026-02-25T02:13:22.970795Z","end":"2026-02-25T02:13:23.088629Z","steps":["trace[1816079678] 'process raft request' (duration: 117.719407ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:13:23.088665Z","caller":"traceutil/trace.go:171","msg":"trace[563619681] linearizableReadLoop","detail":"{readStateIndex:892; appliedIndex:890; }","duration":"344.980131ms","start":"2026-02-25T02:13:22.743665Z","end":"2026-02-25T02:13:23.088645Z","steps":["trace[563619681] 'read index received' (duration: 193.001201ms)","trace[563619681] 'applied index is now lower than readState.Index' (duration: 151.97695ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:13:23.088837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.128482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:13:23.088878Z","caller":"traceutil/trace.go:171","msg":"trace[699910017] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:873; }","duration":"259.200123ms","start":"2026-02-25T02:13:22.829669Z","end":"2026-02-25T02:13:23.088869Z","steps":["trace[699910017] 'agreement among raft nodes before linearized reading' (duration: 259.111981ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:13:23.08889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.095942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T02:13:23.088922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.239337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"} {"level":"warn","ts":"2026-02-25T02:13:23.088948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.808505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:13:23.088952Z","caller":"traceutil/trace.go:171","msg":"trace[1983142276] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:873; }","duration":"240.199675ms","start":"2026-02-25T02:13:22.848732Z","end":"2026-02-25T02:13:23.088931Z","steps":["trace[1983142276] 'agreement among raft nodes before linearized reading' (duration: 240.097112ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:13:23.088955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.735514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T02:13:23.088966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.464738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:13:23.088991Z","caller":"traceutil/trace.go:171","msg":"trace[1523480825] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:873; }","duration":"138.885987ms","start":"2026-02-25T02:13:22.950094Z","end":"2026-02-25T02:13:23.08898Z","steps":["trace[1523480825] 'agreement among raft nodes before linearized reading' (duration: 138.810485ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:13:23.088977Z","caller":"traceutil/trace.go:171","msg":"trace[191185249] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:873; }","duration":"345.328429ms","start":"2026-02-25T02:13:22.743635Z","end":"2026-02-25T02:13:23.088963Z","steps":["trace[191185249] 'agreement among raft nodes before linearized reading' (duration: 345.113275ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:13:23.089007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.49007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:13:23.089021Z","caller":"traceutil/trace.go:171","msg":"trace[730560585] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:873; }","duration":"274.803935ms","start":"2026-02-25T02:13:22.814198Z","end":"2026-02-25T02:13:23.089001Z","steps":["trace[730560585] 'agreement among raft nodes before linearized reading' (duration: 274.726364ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:13:23.089031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:22.743614Z","time spent":"345.408421ms","remote":"127.0.0.1:32816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":550,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"info","ts":"2026-02-25T02:13:23.089052Z","caller":"traceutil/trace.go:171","msg":"trace[1758454691] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:873; }","duration":"259.562152ms","start":"2026-02-25T02:13:22.829473Z","end":"2026-02-25T02:13:23.089035Z","steps":["trace[1758454691] 'agreement among raft nodes before linearized reading' (duration: 259.504621ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:13:23.088871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.647812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T02:13:23.088942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.48307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:13:23.089109Z","caller":"traceutil/trace.go:171","msg":"trace[1860767618] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:873; }","duration":"274.54122ms","start":"2026-02-25T02:13:22.81447Z","end":"2026-02-25T02:13:23.089011Z","steps":["trace[1860767618] 'agreement among raft nodes before linearized reading' (duration: 274.440657ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:13:23.089155Z","caller":"traceutil/trace.go:171","msg":"trace[1188830629] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:873; }","duration":"259.738377ms","start":"2026-02-25T02:13:22.829405Z","end":"2026-02-25T02:13:23.089144Z","steps":["trace[1188830629] 'agreement among raft nodes before linearized reading' (duration: 259.46056ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:13:23.089175Z","caller":"traceutil/trace.go:171","msg":"trace[1522032687] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:873; }","duration":"274.952789ms","start":"2026-02-25T02:13:22.814158Z","end":"2026-02-25T02:13:23.089111Z","steps":["trace[1522032687] 'agreement among raft nodes before linearized reading' (duration: 274.626821ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:13:23.089131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.201657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:13:23.089239Z","caller":"traceutil/trace.go:171","msg":"trace[153911707] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:873; }","duration":"241.329131ms","start":"2026-02-25T02:13:22.847902Z","end":"2026-02-25T02:13:23.089231Z","steps":["trace[153911707] 'agreement among raft nodes before linearized reading' (duration: 241.204218ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:13:23.089085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.033413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:13:23.089296Z","caller":"traceutil/trace.go:171","msg":"trace[1134885530] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:873; }","duration":"241.289009ms","start":"2026-02-25T02:13:22.847997Z","end":"2026-02-25T02:13:23.089286Z","steps":["trace[1134885530] 'agreement among raft nodes before linearized reading' (duration: 241.060654ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:13:38.844828Z","caller":"traceutil/trace.go:171","msg":"trace[2075473574] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"140.125476ms","start":"2026-02-25T02:13:38.704666Z","end":"2026-02-25T02:13:38.844791Z","steps":["trace[2075473574] 'process raft request' (duration: 139.585933ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:14:21.432472Z","caller":"traceutil/trace.go:171","msg":"trace[1425142673] linearizableReadLoop","detail":"{readStateIndex:1559; appliedIndex:1558; }","duration":"132.011298ms","start":"2026-02-25T02:14:21.300411Z","end":"2026-02-25T02:14:21.432422Z","steps":["trace[1425142673] 'read index received' (duration: 131.846155ms)","trace[1425142673] 'applied index is now lower than readState.Index' (duration: 163.753µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:14:21.432561Z","caller":"traceutil/trace.go:171","msg":"trace[1779817917] transaction","detail":"{read_only:false; response_revision:1498; number_of_response:1; }","duration":"134.484505ms","start":"2026-02-25T02:14:21.298003Z","end":"2026-02-25T02:14:21.432487Z","steps":["trace[1779817917] 'process raft request' (duration: 134.25783ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:14:21.432809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.651721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-02-25T02:14:21.432823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.293089ms","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-02-25T02:14:21.432861Z","caller":"traceutil/trace.go:171","msg":"trace[278863810] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1498; }","duration":"125.764883ms","start":"2026-02-25T02:14:21.307082Z","end":"2026-02-25T02:14:21.432847Z","steps":["trace[278863810] 'agreement among raft nodes before linearized reading' (duration: 125.586089ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:14:21.432845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.400317ms","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-02-25T02:14:21.432895Z","caller":"traceutil/trace.go:171","msg":"trace[1828007194] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1498; }","duration":"124.390391ms","start":"2026-02-25T02:14:21.308491Z","end":"2026-02-25T02:14:21.432881Z","steps":["trace[1828007194] 'agreement among raft nodes before linearized reading' (duration: 124.224777ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:14:21.432908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.70191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-25T02:14:21.432945Z","caller":"traceutil/trace.go:171","msg":"trace[105401730] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1498; }","duration":"132.54393ms","start":"2026-02-25T02:14:21.300379Z","end":"2026-02-25T02:14:21.432923Z","steps":["trace[105401730] 'agreement among raft nodes before linearized reading' (duration: 132.266824ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:14:21.432992Z","caller":"traceutil/trace.go:171","msg":"trace[1750438801] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1498; }","duration":"118.829462ms","start":"2026-02-25T02:14:21.314145Z","end":"2026-02-25T02:14:21.432974Z","steps":["trace[1750438801] 'agreement among raft nodes before linearized reading' (duration: 118.557486ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:14:21.603965Z","caller":"traceutil/trace.go:171","msg":"trace[2066713267] transaction","detail":"{read_only:false; response_revision:1499; number_of_response:1; }","duration":"166.697121ms","start":"2026-02-25T02:14:21.43724Z","end":"2026-02-25T02:14:21.603937Z","steps":["trace[2066713267] 'process raft request' (duration: 124.712378ms)","trace[2066713267] 'compare' (duration: 41.844659ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:14:21.606265Z","caller":"traceutil/trace.go:171","msg":"trace[2017426919] transaction","detail":"{read_only:false; response_revision:1502; number_of_response:1; }","duration":"168.386711ms","start":"2026-02-25T02:14:21.43785Z","end":"2026-02-25T02:14:21.606237Z","steps":["trace[2017426919] 'process raft request' (duration: 168.34487ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:14:21.606338Z","caller":"traceutil/trace.go:171","msg":"trace[1315865758] transaction","detail":"{read_only:false; response_revision:1500; number_of_response:1; }","duration":"168.732439ms","start":"2026-02-25T02:14:21.437568Z","end":"2026-02-25T02:14:21.6063Z","steps":["trace[1315865758] 'process raft request' (duration: 168.36691ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:14:21.606377Z","caller":"traceutil/trace.go:171","msg":"trace[249335205] transaction","detail":"{read_only:false; response_revision:1501; number_of_response:1; }","duration":"168.716508ms","start":"2026-02-25T02:14:21.43762Z","end":"2026-02-25T02:14:21.606337Z","steps":["trace[249335205] 'process raft request' (duration: 168.534044ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:22:24.903847Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2136} {"level":"info","ts":"2026-02-25T02:22:24.954904Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2136,"took":"50.438127ms","hash":2380838674,"current-db-size-bytes":14475264,"current-db-size":"14 MB","current-db-size-in-use-bytes":4304896,"current-db-size-in-use":"4.3 MB"} {"level":"info","ts":"2026-02-25T02:22:24.954971Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2380838674,"revision":2136,"compact-revision":-1} {"level":"info","ts":"2026-02-25T02:27:24.912124Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3061} {"level":"info","ts":"2026-02-25T02:27:24.933335Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3061,"took":"20.520365ms","hash":278175111,"current-db-size-bytes":14475264,"current-db-size":"14 MB","current-db-size-in-use-bytes":4689920,"current-db-size-in-use":"4.7 MB"} {"level":"info","ts":"2026-02-25T02:27:24.933433Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":278175111,"revision":3061,"compact-revision":2136}