{"level":"warn","ts":"2026-03-02T09:54:27.531251Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-02T09:54:27.531343Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.244: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.244:2380","--initial-cluster=instance=https://199.204.45.244:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.244:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.244: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-03-02T09:54:27.531406Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-02T09:54:27.531417Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.244:2380"]} {"level":"info","ts":"2026-03-02T09:54:27.531436Z","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-03-02T09:54:27.532102Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"]} {"level":"info","ts":"2026-03-02T09:54:27.532184Z","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.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.244: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-03-02T09:54:27.53785Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.462679ms"} {"level":"info","ts":"2026-03-02T09:54:27.550514Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1686e9b1ea717edf","cluster-id":"71c60fe001ca5b3c"} {"level":"info","ts":"2026-03-02T09:54:27.550634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=()"} {"level":"info","ts":"2026-03-02T09:54:27.550667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 0"} {"level":"info","ts":"2026-03-02T09:54:27.550683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1686e9b1ea717edf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-02T09:54:27.550692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 1"} {"level":"info","ts":"2026-03-02T09:54:27.550804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"} {"level":"warn","ts":"2026-03-02T09:54:27.560997Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-02T09:54:27.562864Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-02T09:54:27.56406Z","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-03-02T09:54:27.566384Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1686e9b1ea717edf","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-02T09:54:27.571391Z","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-03-02T09:54:27.571451Z","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-03-02T09:54:27.571678Z","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-03-02T09:54:27.571706Z","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-03-02T09:54:27.57227Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1686e9b1ea717edf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-02T09:54:27.572371Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.244:2380"} {"level":"info","ts":"2026-03-02T09:54:27.572392Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.244:2380"} {"level":"info","ts":"2026-03-02T09:54:27.572718Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"} {"level":"info","ts":"2026-03-02T09:54:27.572878Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","added-peer-id":"1686e9b1ea717edf","added-peer-peer-urls":["https://199.204.45.244:2380"]} {"level":"info","ts":"2026-03-02T09:54:27.572973Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1686e9b1ea717edf","initial-advertise-peer-urls":["https://199.204.45.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-02T09:54:27.573038Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-02T09:54:28.551188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf is starting a new election at term 1"} {"level":"info","ts":"2026-03-02T09:54:28.55127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became pre-candidate at term 1"} {"level":"info","ts":"2026-03-02T09:54:28.551318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgPreVoteResp from 1686e9b1ea717edf at term 1"} {"level":"info","ts":"2026-03-02T09:54:28.551523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became candidate at term 2"} {"level":"info","ts":"2026-03-02T09:54:28.551551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgVoteResp from 1686e9b1ea717edf at term 2"} {"level":"info","ts":"2026-03-02T09:54:28.55157Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became leader at term 2"} {"level":"info","ts":"2026-03-02T09:54:28.551587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1686e9b1ea717edf elected leader 1686e9b1ea717edf at term 2"} {"level":"info","ts":"2026-03-02T09:54:28.552739Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-02T09:54:28.553682Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1686e9b1ea717edf","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.244:2379]}","request-path":"/0/members/1686e9b1ea717edf/attributes","cluster-id":"71c60fe001ca5b3c","publish-timeout":"7s"} {"level":"info","ts":"2026-03-02T09:54:28.553715Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-02T09:54:28.553724Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-02T09:54:28.553939Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-02T09:54:28.554056Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-02T09:54:28.554185Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","cluster-version":"3.5"} {"level":"info","ts":"2026-03-02T09:54:28.554344Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-02T09:54:28.554394Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-02T09:54:28.555564Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-02T09:54:28.566704Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.244:2379"} {"level":"info","ts":"2026-03-02T09:54:30.142617Z","caller":"traceutil/trace.go:171","msg":"trace[1923126058] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"100.370712ms","start":"2026-03-02T09:54:30.042179Z","end":"2026-03-02T09:54:30.14255Z","steps":["trace[1923126058] 'process raft request' (duration: 88.260385ms)","trace[1923126058] 'compare' (duration: 11.741447ms)"],"step_count":2} {"level":"info","ts":"2026-03-02T09:54:30.142924Z","caller":"traceutil/trace.go:171","msg":"trace[1534135491] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"100.425786ms","start":"2026-03-02T09:54:30.042449Z","end":"2026-03-02T09:54:30.142875Z","steps":["trace[1534135491] 'process raft request' (duration: 100.172776ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:30.143053Z","caller":"traceutil/trace.go:171","msg":"trace[1210674332] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"100.559367ms","start":"2026-03-02T09:54:30.042476Z","end":"2026-03-02T09:54:30.143036Z","steps":["trace[1210674332] 'process raft request' (duration: 100.185507ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:30.143179Z","caller":"traceutil/trace.go:171","msg":"trace[1713355127] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"100.746873ms","start":"2026-03-02T09:54:30.042389Z","end":"2026-03-02T09:54:30.143136Z","steps":["trace[1713355127] 'process raft request' (duration: 100.135893ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:30.143284Z","caller":"traceutil/trace.go:171","msg":"trace[1581251215] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"100.877294ms","start":"2026-03-02T09:54:30.042386Z","end":"2026-03-02T09:54:30.143264Z","steps":["trace[1581251215] 'process raft request' (duration: 100.08884ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:30.143342Z","caller":"traceutil/trace.go:171","msg":"trace[1265237660] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"100.281676ms","start":"2026-03-02T09:54:30.04299Z","end":"2026-03-02T09:54:30.143272Z","steps":["trace[1265237660] 'process raft request' (duration: 99.726831ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:30.143432Z","caller":"traceutil/trace.go:171","msg":"trace[1705465336] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"100.994372ms","start":"2026-03-02T09:54:30.042413Z","end":"2026-03-02T09:54:30.143407Z","steps":["trace[1705465336] 'process raft request' (duration: 100.140784ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:30.801829Z","caller":"traceutil/trace.go:171","msg":"trace[925319297] transaction","detail":"{read_only:false; response_revision:61; number_of_response:1; }","duration":"136.664424ms","start":"2026-03-02T09:54:30.665106Z","end":"2026-03-02T09:54:30.801771Z","steps":["trace[925319297] 'process raft request' (duration: 53.836586ms)","trace[925319297] 'compare' (duration: 82.370141ms)"],"step_count":2} {"level":"info","ts":"2026-03-02T09:54:30.802074Z","caller":"traceutil/trace.go:171","msg":"trace[805561194] transaction","detail":"{read_only:false; response_revision:62; number_of_response:1; }","duration":"134.641651ms","start":"2026-03-02T09:54:30.667263Z","end":"2026-03-02T09:54:30.801905Z","steps":["trace[805561194] 'process raft request' (duration: 134.236898ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:38.212259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.720305ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-02T09:54:38.212605Z","caller":"traceutil/trace.go:171","msg":"trace[649881552] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"187.377339ms","start":"2026-03-02T09:54:38.02521Z","end":"2026-03-02T09:54:38.212587Z","steps":["trace[649881552] 'process raft request' (duration: 51.815975ms)","trace[649881552] 'compare' (duration: 134.485556ms)"],"step_count":2} {"level":"info","ts":"2026-03-02T09:54:38.212672Z","caller":"traceutil/trace.go:171","msg":"trace[1730667152] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"186.17032ms","start":"2026-03-02T09:54:38.026474Z","end":"2026-03-02T09:54:38.212644Z","steps":["trace[1730667152] 'process raft request' (duration: 185.989946ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:38.212721Z","caller":"traceutil/trace.go:171","msg":"trace[1072051147] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"186.675201ms","start":"2026-03-02T09:54:38.026003Z","end":"2026-03-02T09:54:38.212678Z","steps":["trace[1072051147] 'process raft request' (duration: 186.379987ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:38.212912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.325784ms","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-03-02T09:54:38.212987Z","caller":"traceutil/trace.go:171","msg":"trace[1292519925] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:311; }","duration":"187.423533ms","start":"2026-03-02T09:54:38.025555Z","end":"2026-03-02T09:54:38.212979Z","steps":["trace[1292519925] 'agreement among raft nodes before linearized reading' (duration: 187.317904ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:38.21254Z","caller":"traceutil/trace.go:171","msg":"trace[76254582] linearizableReadLoop","detail":"{readStateIndex:319; appliedIndex:316; }","duration":"186.945003ms","start":"2026-03-02T09:54:38.025575Z","end":"2026-03-02T09:54:38.21252Z","steps":["trace[76254582] 'read index received' (duration: 7.287854ms)","trace[76254582] 'applied index is now lower than readState.Index' (duration: 179.653769ms)"],"step_count":2} {"level":"warn","ts":"2026-03-02T09:54:38.213282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.229578ms","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-03-02T09:54:38.213334Z","caller":"traceutil/trace.go:171","msg":"trace[748169851] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:311; }","duration":"136.317136ms","start":"2026-03-02T09:54:38.077002Z","end":"2026-03-02T09:54:38.21332Z","steps":["trace[748169851] 'agreement among raft nodes before linearized reading' (duration: 136.234179ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:38.817571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.021472ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-02T09:54:38.817714Z","caller":"traceutil/trace.go:171","msg":"trace[2031092029] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"598.070469ms","start":"2026-03-02T09:54:38.219624Z","end":"2026-03-02T09:54:38.817695Z","steps":["trace[2031092029] 'process raft request' (duration: 211.851074ms)","trace[2031092029] 'compare' (duration: 385.855622ms)"],"step_count":2} {"level":"warn","ts":"2026-03-02T09:54:38.81778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.21961Z","time spent":"598.144975ms","remote":"127.0.0.1:57298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":687,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-02T09:54:38.856007Z","caller":"traceutil/trace.go:171","msg":"trace[2120089179] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"633.264616ms","start":"2026-03-02T09:54:38.22271Z","end":"2026-03-02T09:54:38.855974Z","steps":["trace[2120089179] 'process raft request' (duration: 633.080484ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:38.856262Z","caller":"traceutil/trace.go:171","msg":"trace[130604660] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"632.286982ms","start":"2026-03-02T09:54:38.223951Z","end":"2026-03-02T09:54:38.856238Z","steps":["trace[130604660] 'process raft request' (duration: 631.965251ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:38.85648Z","caller":"traceutil/trace.go:171","msg":"trace[1933071479] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"631.581099ms","start":"2026-03-02T09:54:38.224887Z","end":"2026-03-02T09:54:38.856468Z","steps":["trace[1933071479] 'process raft request' (duration: 631.205805ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:38.856501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.222678Z","time spent":"633.404275ms","remote":"127.0.0.1:57380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4355,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-02T09:54:38.856544Z","caller":"traceutil/trace.go:171","msg":"trace[1847623957] linearizableReadLoop","detail":"{readStateIndex:327; appliedIndex:321; }","duration":"630.265362ms","start":"2026-03-02T09:54:38.226257Z","end":"2026-03-02T09:54:38.856522Z","steps":["trace[1847623957] 'read index received' (duration: 205.258588ms)","trace[1847623957] 'applied index is now lower than readState.Index' (duration: 425.005844ms)"],"step_count":2} {"level":"info","ts":"2026-03-02T09:54:38.8566Z","caller":"traceutil/trace.go:171","msg":"trace[1774995377] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"631.424965ms","start":"2026-03-02T09:54:38.225163Z","end":"2026-03-02T09:54:38.856588Z","steps":["trace[1774995377] 'process raft request' (duration: 631.276726ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:38.856608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.224872Z","time spent":"631.637674ms","remote":"127.0.0.1:57560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2191,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-02T09:54:38.856642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.225142Z","time spent":"631.480129ms","remote":"127.0.0.1:57560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2094,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-02T09:54:38.856705Z","caller":"traceutil/trace.go:171","msg":"trace[2045432179] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"631.800233ms","start":"2026-03-02T09:54:38.2249Z","end":"2026-03-02T09:54:38.8567Z","steps":["trace[2045432179] 'process raft request' (duration: 631.448781ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:38.856731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.224887Z","time spent":"631.831476ms","remote":"127.0.0.1:57560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":899,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-02T09:54:38.85677Z","caller":"traceutil/trace.go:171","msg":"trace[222793558] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"628.277165ms","start":"2026-03-02T09:54:38.228482Z","end":"2026-03-02T09:54:38.856759Z","steps":["trace[222793558] 'process raft request' (duration: 627.992337ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:38.856764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.223938Z","time spent":"632.388748ms","remote":"127.0.0.1:57438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1251,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-02T09:54:38.85687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.868706ms","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-03-02T09:54:38.856892Z","caller":"traceutil/trace.go:171","msg":"trace[967121328] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:318; }","duration":"579.938841ms","start":"2026-03-02T09:54:38.276946Z","end":"2026-03-02T09:54:38.856885Z","steps":["trace[967121328] 'agreement among raft nodes before linearized reading' (duration: 579.899889ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:38.856906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.276921Z","time spent":"579.980924ms","remote":"127.0.0.1:57410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":236,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"warn","ts":"2026-03-02T09:54:38.856906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.228442Z","time spent":"628.361491ms","remote":"127.0.0.1:57394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4451,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-02T09:54:38.85697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.114436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"warn","ts":"2026-03-02T09:54:38.85698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.933905ms","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-03-02T09:54:38.856993Z","caller":"traceutil/trace.go:171","msg":"trace[1759216378] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:318; }","duration":"518.972689ms","start":"2026-03-02T09:54:38.338016Z","end":"2026-03-02T09:54:38.856989Z","steps":["trace[1759216378] 'agreement among raft nodes before linearized reading' (duration: 518.947177ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:38.856994Z","caller":"traceutil/trace.go:171","msg":"trace[1580584809] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:318; }","duration":"510.16482ms","start":"2026-03-02T09:54:38.346823Z","end":"2026-03-02T09:54:38.856988Z","steps":["trace[1580584809] 'agreement among raft nodes before linearized reading' (duration: 510.121457ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:38.857005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.338004Z","time spent":"518.998461ms","remote":"127.0.0.1:57410","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-03-02T09:54:38.857016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.34681Z","time spent":"510.202294ms","remote":"127.0.0.1:57410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":207,"request content":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" "} {"level":"warn","ts":"2026-03-02T09:54:38.857068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.619253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-03-02T09:54:38.857108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.643629ms","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-03-02T09:54:38.857127Z","caller":"traceutil/trace.go:171","msg":"trace[1704348428] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:318; }","duration":"479.722016ms","start":"2026-03-02T09:54:38.377399Z","end":"2026-03-02T09:54:38.857121Z","steps":["trace[1704348428] 'agreement among raft nodes before linearized reading' (duration: 479.689103ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:38.857185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.935085ms","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-03-02T09:54:38.8572Z","caller":"traceutil/trace.go:171","msg":"trace[880414424] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:318; }","duration":"630.969267ms","start":"2026-03-02T09:54:38.226226Z","end":"2026-03-02T09:54:38.857196Z","steps":["trace[880414424] 'agreement among raft nodes before linearized reading' (duration: 630.942446ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:38.857145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.377346Z","time spent":"479.793482ms","remote":"127.0.0.1:57410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"warn","ts":"2026-03-02T09:54:38.857213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.22622Z","time spent":"630.988779ms","remote":"127.0.0.1:57410","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-03-02T09:54:38.857281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.861988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-03-02T09:54:38.857296Z","caller":"traceutil/trace.go:171","msg":"trace[1047104174] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:318; }","duration":"559.927833ms","start":"2026-03-02T09:54:38.297364Z","end":"2026-03-02T09:54:38.857292Z","steps":["trace[1047104174] 'agreement among raft nodes before linearized reading' (duration: 559.901661ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:38.857308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.297333Z","time spent":"559.972456ms","remote":"127.0.0.1:57448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-03-02T09:54:38.857361Z","caller":"traceutil/trace.go:171","msg":"trace[1361751814] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:318; }","duration":"566.691428ms","start":"2026-03-02T09:54:38.290403Z","end":"2026-03-02T09:54:38.857094Z","steps":["trace[1361751814] 'agreement among raft nodes before linearized reading' (duration: 566.584471ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:38.857407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.290383Z","time spent":"567.012769ms","remote":"127.0.0.1:57448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-02T09:54:39.189739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.12034ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-02T09:54:39.190068Z","caller":"traceutil/trace.go:171","msg":"trace[1814242660] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"324.610152ms","start":"2026-03-02T09:54:38.865419Z","end":"2026-03-02T09:54:39.190029Z","steps":["trace[1814242660] 'process raft request' (duration: 125.138157ms)","trace[1814242660] 'compare' (duration: 198.956851ms)"],"step_count":2} {"level":"info","ts":"2026-03-02T09:54:39.19016Z","caller":"traceutil/trace.go:171","msg":"trace[1568231838] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"324.231294ms","start":"2026-03-02T09:54:38.865899Z","end":"2026-03-02T09:54:39.19013Z","steps":["trace[1568231838] 'process raft request' (duration: 323.929435ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:39.190198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.865397Z","time spent":"324.741707ms","remote":"127.0.0.1:57460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-02T09:54:39.190288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.865875Z","time spent":"324.34885ms","remote":"127.0.0.1:57448","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-03-02T09:54:39.19054Z","caller":"traceutil/trace.go:171","msg":"trace[822398335] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"324.631307ms","start":"2026-03-02T09:54:38.865898Z","end":"2026-03-02T09:54:39.190529Z","steps":["trace[822398335] 'process raft request' (duration: 324.090544ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:39.190547Z","caller":"traceutil/trace.go:171","msg":"trace[864262849] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"322.760137ms","start":"2026-03-02T09:54:38.867768Z","end":"2026-03-02T09:54:39.190528Z","steps":["trace[864262849] 'process raft request' (duration: 322.626366ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:39.190589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.865882Z","time spent":"324.683295ms","remote":"127.0.0.1:57560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2264,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-02T09:54:39.190565Z","caller":"traceutil/trace.go:171","msg":"trace[1726195672] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"323.342699ms","start":"2026-03-02T09:54:38.867151Z","end":"2026-03-02T09:54:39.190494Z","steps":["trace[1726195672] 'process raft request' (duration: 322.964255ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:39.19071Z","caller":"traceutil/trace.go:171","msg":"trace[1120808652] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"323.555955ms","start":"2026-03-02T09:54:38.867146Z","end":"2026-03-02T09:54:39.190702Z","steps":["trace[1120808652] 'process raft request' (duration: 322.932018ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:39.190753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.867131Z","time spent":"323.605823ms","remote":"127.0.0.1:57686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3642,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-02T09:54:39.190752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.867137Z","time spent":"323.533898ms","remote":"127.0.0.1:57298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":649,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-02T09:54:39.190856Z","caller":"traceutil/trace.go:171","msg":"trace[2100578833] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"322.84651ms","start":"2026-03-02T09:54:38.867997Z","end":"2026-03-02T09:54:39.190843Z","steps":["trace[2100578833] 'process raft request' (duration: 322.491235ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:39.190932Z","caller":"traceutil/trace.go:171","msg":"trace[385087424] linearizableReadLoop","detail":"{readStateIndex:336; appliedIndex:328; }","duration":"323.095845ms","start":"2026-03-02T09:54:38.867828Z","end":"2026-03-02T09:54:39.190924Z","steps":["trace[385087424] 'read index received' (duration: 38.981353ms)","trace[385087424] 'applied index is now lower than readState.Index' (duration: 284.113112ms)"],"step_count":2} {"level":"warn","ts":"2026-03-02T09:54:39.190942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.867977Z","time spent":"322.921637ms","remote":"127.0.0.1:57560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3461,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-02T09:54:39.190669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.867749Z","time spent":"322.841373ms","remote":"127.0.0.1:57438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2267,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-02T09:54:39.191075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.233216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-nfls4\" ","response":"range_response_count:1 size:4466"} {"level":"warn","ts":"2026-03-02T09:54:39.191097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.20012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5336"} {"level":"info","ts":"2026-03-02T09:54:39.190907Z","caller":"traceutil/trace.go:171","msg":"trace[1588118606] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"323.069789ms","start":"2026-03-02T09:54:38.867737Z","end":"2026-03-02T09:54:39.190807Z","steps":["trace[1588118606] 'process raft request' (duration: 322.410305ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:39.191148Z","caller":"traceutil/trace.go:171","msg":"trace[722518671] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"320.331288ms","start":"2026-03-02T09:54:38.870808Z","end":"2026-03-02T09:54:39.191139Z","steps":["trace[722518671] 'process raft request' (duration: 319.88254ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:39.191365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.870801Z","time spent":"320.528135ms","remote":"127.0.0.1:57380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4411,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-02T09:54:39.191139Z","caller":"traceutil/trace.go:171","msg":"trace[40729402] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-nfls4; range_end:; response_count:1; response_revision:328; }","duration":"323.293482ms","start":"2026-03-02T09:54:38.867825Z","end":"2026-03-02T09:54:39.191118Z","steps":["trace[40729402] 'agreement among raft nodes before linearized reading' (duration: 323.185719ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:39.191535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.867804Z","time spent":"323.721725ms","remote":"127.0.0.1:57394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":4488,"request content":"key:\"/registry/pods/kube-system/kube-proxy-nfls4\" "} {"level":"info","ts":"2026-03-02T09:54:39.191144Z","caller":"traceutil/trace.go:171","msg":"trace[1585009273] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:328; }","duration":"323.254618ms","start":"2026-03-02T09:54:38.867874Z","end":"2026-03-02T09:54:39.191129Z","steps":["trace[1585009273] 'agreement among raft nodes before linearized reading' (duration: 323.176584ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:39.191694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.86787Z","time spent":"323.8148ms","remote":"127.0.0.1:57394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5358,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"warn","ts":"2026-03-02T09:54:39.192605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:38.867208Z","time spent":"323.987066ms","remote":"127.0.0.1:57410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-02T09:54:39.373067Z","caller":"traceutil/trace.go:171","msg":"trace[1004971195] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"114.110249ms","start":"2026-03-02T09:54:39.25893Z","end":"2026-03-02T09:54:39.37304Z","steps":["trace[1004971195] 'process raft request' (duration: 87.25879ms)","trace[1004971195] 'compare' (duration: 26.242661ms)"],"step_count":2} {"level":"info","ts":"2026-03-02T09:54:39.37313Z","caller":"traceutil/trace.go:171","msg":"trace[1857169677] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"106.230155ms","start":"2026-03-02T09:54:39.266879Z","end":"2026-03-02T09:54:39.373109Z","steps":["trace[1857169677] 'process raft request' (duration: 106.181378ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:39.373167Z","caller":"traceutil/trace.go:171","msg":"trace[195450702] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"113.193713ms","start":"2026-03-02T09:54:39.259945Z","end":"2026-03-02T09:54:39.373138Z","steps":["trace[195450702] 'process raft request' (duration: 113.081361ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:39.373244Z","caller":"traceutil/trace.go:171","msg":"trace[118998722] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"113.308855ms","start":"2026-03-02T09:54:39.25981Z","end":"2026-03-02T09:54:39.373119Z","steps":["trace[118998722] 'process raft request' (duration: 113.142657ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:43.035032Z","caller":"traceutil/trace.go:171","msg":"trace[937176798] linearizableReadLoop","detail":"{readStateIndex:377; appliedIndex:376; }","duration":"111.305736ms","start":"2026-03-02T09:54:42.923702Z","end":"2026-03-02T09:54:43.035008Z","steps":["trace[937176798] 'read index received' (duration: 111.143776ms)","trace[937176798] 'applied index is now lower than readState.Index' (duration: 160.93µs)"],"step_count":2} {"level":"info","ts":"2026-03-02T09:54:43.035126Z","caller":"traceutil/trace.go:171","msg":"trace[1823683042] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"157.971535ms","start":"2026-03-02T09:54:42.877115Z","end":"2026-03-02T09:54:43.035086Z","steps":["trace[1823683042] 'process raft request' (duration: 157.708301ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:43.035556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.448478ms","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-03-02T09:54:43.03564Z","caller":"traceutil/trace.go:171","msg":"trace[523139766] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:365; }","duration":"111.946427ms","start":"2026-03-02T09:54:42.92367Z","end":"2026-03-02T09:54:43.035617Z","steps":["trace[523139766] 'agreement among raft nodes before linearized reading' (duration: 111.431178ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:50.846098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.605650216s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-03-02T09:54:50.846196Z","caller":"traceutil/trace.go:171","msg":"trace[1339953346] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:411; }","duration":"1.605801538s","start":"2026-03-02T09:54:49.240372Z","end":"2026-03-02T09:54:50.846173Z","steps":["trace[1339953346] 'range keys from in-memory index tree' (duration: 1.605525101s)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:50.8462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.239143899s","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-03-02T09:54:50.846298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.777929873s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-03-02T09:54:50.846305Z","caller":"traceutil/trace.go:171","msg":"trace[1997082698] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:411; }","duration":"1.239309622s","start":"2026-03-02T09:54:49.606972Z","end":"2026-03-02T09:54:50.846281Z","steps":["trace[1997082698] 'range keys from in-memory index tree' (duration: 1.238972478s)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:50.846328Z","caller":"traceutil/trace.go:171","msg":"trace[1527752813] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:411; }","duration":"1.777994139s","start":"2026-03-02T09:54:49.068323Z","end":"2026-03-02T09:54:50.846318Z","steps":["trace[1527752813] 'range keys from in-memory index tree' (duration: 1.777847046s)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:50.846358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:49.068306Z","time spent":"1.778046817s","remote":"127.0.0.1:57448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-02T09:54:50.846361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:49.606942Z","time spent":"1.239405287s","remote":"127.0.0.1:57448","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-03-02T09:54:50.846689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.743969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-02T09:54:50.846734Z","caller":"traceutil/trace.go:171","msg":"trace[1823890164] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:411; }","duration":"740.813966ms","start":"2026-03-02T09:54:50.105906Z","end":"2026-03-02T09:54:50.84672Z","steps":["trace[1823890164] 'range keys from in-memory index tree' (duration: 740.642075ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:50.846772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:50.105892Z","time spent":"740.869474ms","remote":"127.0.0.1:57448","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-03-02T09:54:50.846245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:49.240353Z","time spent":"1.605882204s","remote":"127.0.0.1:57448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-02T09:54:50.847124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.24787743s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-02T09:54:50.847165Z","caller":"traceutil/trace.go:171","msg":"trace[1588041785] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:411; }","duration":"1.247972305s","start":"2026-03-02T09:54:49.599179Z","end":"2026-03-02T09:54:50.847151Z","steps":["trace[1588041785] 'range keys from in-memory index tree' (duration: 1.247752306s)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:50.847193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:49.599147Z","time spent":"1.248040012s","remote":"127.0.0.1:57220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-02T09:54:50.940262Z","caller":"traceutil/trace.go:171","msg":"trace[408770069] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"556.116918ms","start":"2026-03-02T09:54:50.384092Z","end":"2026-03-02T09:54:50.940209Z","steps":["trace[408770069] 'process raft request' (duration: 555.761505ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:50.940509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:50.384068Z","time spent":"556.341288ms","remote":"127.0.0.1:57448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-02T09:54:50.984744Z","caller":"traceutil/trace.go:171","msg":"trace[2089164971] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"134.896039ms","start":"2026-03-02T09:54:50.84981Z","end":"2026-03-02T09:54:50.984706Z","steps":["trace[2089164971] 'process raft request' (duration: 133.972893ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:50.985906Z","caller":"traceutil/trace.go:171","msg":"trace[1148979553] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"135.970468ms","start":"2026-03-02T09:54:50.849893Z","end":"2026-03-02T09:54:50.985864Z","steps":["trace[1148979553] 'process raft request' (duration: 134.518467ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:50.986541Z","caller":"traceutil/trace.go:171","msg":"trace[1954601198] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"136.478184ms","start":"2026-03-02T09:54:50.850031Z","end":"2026-03-02T09:54:50.98651Z","steps":["trace[1954601198] 'process raft request' (duration: 135.50595ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:50.988026Z","caller":"traceutil/trace.go:171","msg":"trace[694318958] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"136.945882ms","start":"2026-03-02T09:54:50.851055Z","end":"2026-03-02T09:54:50.988001Z","steps":["trace[694318958] 'process raft request' (duration: 135.08025ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:54:57.434341Z","caller":"traceutil/trace.go:171","msg":"trace[907921789] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"381.07911ms","start":"2026-03-02T09:54:57.053234Z","end":"2026-03-02T09:54:57.434314Z","steps":["trace[907921789] 'process raft request' (duration: 326.121927ms)","trace[907921789] 'compare' (duration: 54.797949ms)"],"step_count":2} {"level":"warn","ts":"2026-03-02T09:54:57.434501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:57.053214Z","time spent":"381.209377ms","remote":"127.0.0.1:57448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-02T09:54:57.43467Z","caller":"traceutil/trace.go:171","msg":"trace[133119785] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"378.236552ms","start":"2026-03-02T09:54:57.056403Z","end":"2026-03-02T09:54:57.43464Z","steps":["trace[133119785] 'process raft request' (duration: 377.870215ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:57.43485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:57.056389Z","time spent":"378.371788ms","remote":"127.0.0.1:57448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-02T09:54:57.435421Z","caller":"traceutil/trace.go:171","msg":"trace[1141350883] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"378.0117ms","start":"2026-03-02T09:54:57.057397Z","end":"2026-03-02T09:54:57.435408Z","steps":["trace[1141350883] 'process raft request' (duration: 377.17192ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:57.4355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:57.05739Z","time spent":"378.072809ms","remote":"127.0.0.1:57448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-02T09:54:58.053824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.675673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-02T09:54:58.053906Z","caller":"traceutil/trace.go:171","msg":"trace[274625802] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:430; }","duration":"454.808818ms","start":"2026-03-02T09:54:57.599078Z","end":"2026-03-02T09:54:58.053887Z","steps":["trace[274625802] 'range keys from in-memory index tree' (duration: 454.581776ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:54:58.05396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:54:57.599058Z","time spent":"454.892925ms","remote":"127.0.0.1:57220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-02T09:55:06.533115Z","caller":"traceutil/trace.go:171","msg":"trace[54638838] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"104.235456ms","start":"2026-03-02T09:55:06.428816Z","end":"2026-03-02T09:55:06.533052Z","steps":["trace[54638838] 'process raft request' (duration: 103.955102ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:55:11.424854Z","caller":"traceutil/trace.go:171","msg":"trace[1887552048] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"230.285569ms","start":"2026-03-02T09:55:11.194551Z","end":"2026-03-02T09:55:11.424837Z","steps":["trace[1887552048] 'process raft request' (duration: 230.18566ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:55:11.432491Z","caller":"traceutil/trace.go:171","msg":"trace[2121332749] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"138.975571ms","start":"2026-03-02T09:55:11.2935Z","end":"2026-03-02T09:55:11.432475Z","steps":["trace[2121332749] 'process raft request' (duration: 138.890412ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:55:13.614722Z","caller":"traceutil/trace.go:171","msg":"trace[714178915] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"183.486982ms","start":"2026-03-02T09:55:13.4312Z","end":"2026-03-02T09:55:13.614687Z","steps":["trace[714178915] 'process raft request' (duration: 183.056047ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:55:17.977344Z","caller":"traceutil/trace.go:171","msg":"trace[1499169972] linearizableReadLoop","detail":"{readStateIndex:553; appliedIndex:552; }","duration":"247.086911ms","start":"2026-03-02T09:55:17.730218Z","end":"2026-03-02T09:55:17.977304Z","steps":["trace[1499169972] 'read index received' (duration: 166.380591ms)","trace[1499169972] 'applied index is now lower than readState.Index' (duration: 80.70486ms)"],"step_count":2} {"level":"warn","ts":"2026-03-02T09:55:17.977489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.284958ms","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-03-02T09:55:17.977523Z","caller":"traceutil/trace.go:171","msg":"trace[1350659762] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:532; }","duration":"247.381068ms","start":"2026-03-02T09:55:17.73013Z","end":"2026-03-02T09:55:17.977511Z","steps":["trace[1350659762] 'agreement among raft nodes before linearized reading' (duration: 247.280899ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:55:17.977553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.089268ms","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-03-02T09:55:17.977578Z","caller":"traceutil/trace.go:171","msg":"trace[1425031938] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:532; }","duration":"223.154748ms","start":"2026-03-02T09:55:17.754415Z","end":"2026-03-02T09:55:17.977569Z","steps":["trace[1425031938] 'agreement among raft nodes before linearized reading' (duration: 223.050588ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:55:17.977724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.955772ms","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-03-02T09:55:17.977764Z","caller":"traceutil/trace.go:171","msg":"trace[2027021320] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:532; }","duration":"138.020432ms","start":"2026-03-02T09:55:17.839734Z","end":"2026-03-02T09:55:17.977754Z","steps":["trace[2027021320] 'agreement among raft nodes before linearized reading' (duration: 137.931633ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:55:17.977882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.801676ms","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-03-02T09:55:17.977922Z","caller":"traceutil/trace.go:171","msg":"trace[470132407] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:532; }","duration":"138.902295ms","start":"2026-03-02T09:55:17.839014Z","end":"2026-03-02T09:55:17.977916Z","steps":["trace[470132407] 'agreement among raft nodes before linearized reading' (duration: 138.810596ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:55:18.147845Z","caller":"traceutil/trace.go:171","msg":"trace[1393256607] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"164.624606ms","start":"2026-03-02T09:55:17.983196Z","end":"2026-03-02T09:55:18.14782Z","steps":["trace[1393256607] 'process raft request' (duration: 164.523096ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:55:18.147888Z","caller":"traceutil/trace.go:171","msg":"trace[1169946012] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"164.645255ms","start":"2026-03-02T09:55:17.983197Z","end":"2026-03-02T09:55:18.147842Z","steps":["trace[1169946012] 'process raft request' (duration: 125.042828ms)","trace[1169946012] 'compare' (duration: 39.316919ms)"],"step_count":2} {"level":"info","ts":"2026-03-02T09:55:18.14819Z","caller":"traceutil/trace.go:171","msg":"trace[2044896491] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"164.856834ms","start":"2026-03-02T09:55:17.98331Z","end":"2026-03-02T09:55:18.148167Z","steps":["trace[2044896491] 'process raft request' (duration: 164.466267ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:55:18.338725Z","caller":"traceutil/trace.go:171","msg":"trace[386982954] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"176.156991ms","start":"2026-03-02T09:55:18.162539Z","end":"2026-03-02T09:55:18.338696Z","steps":["trace[386982954] 'process raft request' (duration: 167.128721ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:55:18.975874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.116114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-02T09:55:18.975979Z","caller":"traceutil/trace.go:171","msg":"trace[29902762] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:537; }","duration":"376.77773ms","start":"2026-03-02T09:55:18.599181Z","end":"2026-03-02T09:55:18.975958Z","steps":["trace[29902762] 'range keys from in-memory index tree' (duration: 375.989274ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:55:18.976024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:55:18.599141Z","time spent":"376.874268ms","remote":"127.0.0.1:57220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-02T09:55:20.550575Z","caller":"traceutil/trace.go:171","msg":"trace[492984936] linearizableReadLoop","detail":"{readStateIndex:559; appliedIndex:558; }","duration":"389.942576ms","start":"2026-03-02T09:55:20.160602Z","end":"2026-03-02T09:55:20.550545Z","steps":["trace[492984936] 'read index received' (duration: 389.632847ms)","trace[492984936] 'applied index is now lower than readState.Index' (duration: 308.529µs)"],"step_count":2} {"level":"info","ts":"2026-03-02T09:55:20.550643Z","caller":"traceutil/trace.go:171","msg":"trace[1753698319] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"552.427366ms","start":"2026-03-02T09:55:19.998182Z","end":"2026-03-02T09:55:20.550609Z","steps":["trace[1753698319] 'process raft request' (duration: 552.124607ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:55:20.550811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:55:19.998142Z","time spent":"552.573145ms","remote":"127.0.0.1:57448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-02T09:55:20.550852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.217225ms","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-03-02T09:55:20.550904Z","caller":"traceutil/trace.go:171","msg":"trace[1380691306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:538; }","duration":"390.326625ms","start":"2026-03-02T09:55:20.160564Z","end":"2026-03-02T09:55:20.550891Z","steps":["trace[1380691306] 'agreement among raft nodes before linearized reading' (duration: 390.129176ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:55:20.550945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:55:20.160544Z","time spent":"390.391924ms","remote":"127.0.0.1:57448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-02T09:55:20.55126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.713037ms","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-03-02T09:55:20.551391Z","caller":"traceutil/trace.go:171","msg":"trace[2110817244] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:538; }","duration":"389.886487ms","start":"2026-03-02T09:55:20.161469Z","end":"2026-03-02T09:55:20.551356Z","steps":["trace[2110817244] 'agreement among raft nodes before linearized reading' (duration: 389.504078ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:55:20.55148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.494834ms","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-03-02T09:55:20.551564Z","caller":"traceutil/trace.go:171","msg":"trace[1182069345] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:538; }","duration":"390.903112ms","start":"2026-03-02T09:55:20.160639Z","end":"2026-03-02T09:55:20.551542Z","steps":["trace[1182069345] 'agreement among raft nodes before linearized reading' (duration: 390.275765ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:55:20.551618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:55:20.160626Z","time spent":"390.982522ms","remote":"127.0.0.1:57448","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":"warn","ts":"2026-03-02T09:55:20.5515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:55:20.161448Z","time spent":"390.036166ms","remote":"127.0.0.1:57448","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-03-02T09:55:21.100197Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142198039597179571,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-02T09:55:21.61234Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142198039597179571,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-02T09:55:21.709355Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.152881444s","expected-duration":"1s"} {"level":"info","ts":"2026-03-02T09:55:21.750886Z","caller":"traceutil/trace.go:171","msg":"trace[14677578] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"1.194505429s","start":"2026-03-02T09:55:20.556356Z","end":"2026-03-02T09:55:21.750862Z","steps":["trace[14677578] 'process raft request' (duration: 1.153345912s)","trace[14677578] 'compare' (duration: 40.945107ms)"],"step_count":2} {"level":"warn","ts":"2026-03-02T09:55:21.751031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:55:20.556325Z","time spent":"1.194632318s","remote":"127.0.0.1:57448","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-03-02T09:55:21.759169Z","caller":"traceutil/trace.go:171","msg":"trace[1891478036] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"1.183950614s","start":"2026-03-02T09:55:20.575193Z","end":"2026-03-02T09:55:21.759144Z","steps":["trace[1891478036] 'process raft request' (duration: 1.183849064s)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:55:21.759167Z","caller":"traceutil/trace.go:171","msg":"trace[413069260] linearizableReadLoop","detail":"{readStateIndex:562; appliedIndex:559; }","duration":"1.159264211s","start":"2026-03-02T09:55:20.599863Z","end":"2026-03-02T09:55:21.759127Z","steps":["trace[413069260] 'read index received' (duration: 1.1098998s)","trace[413069260] 'applied index is now lower than readState.Index' (duration: 49.363131ms)"],"step_count":2} {"level":"info","ts":"2026-03-02T09:55:21.759236Z","caller":"traceutil/trace.go:171","msg":"trace[17985570] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"1.202504494s","start":"2026-03-02T09:55:20.556692Z","end":"2026-03-02T09:55:21.759196Z","steps":["trace[17985570] 'process raft request' (duration: 1.202214995s)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:55:21.759306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.159415091s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-02T09:55:21.759311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:55:20.57518Z","time spent":"1.184049354s","remote":"127.0.0.1:57448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-02T09:55:21.759342Z","caller":"traceutil/trace.go:171","msg":"trace[973842880] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:542; }","duration":"1.15952689s","start":"2026-03-02T09:55:20.599803Z","end":"2026-03-02T09:55:21.75933Z","steps":["trace[973842880] 'agreement among raft nodes before linearized reading' (duration: 1.159444861s)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:55:21.75938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:55:20.599776Z","time spent":"1.15959687s","remote":"127.0.0.1:57228","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-03-02T09:55:21.7595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:55:20.556644Z","time spent":"1.202678502s","remote":"127.0.0.1:57448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-02T09:55:21.759555Z","caller":"traceutil/trace.go:171","msg":"trace[1828862946] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"132.017474ms","start":"2026-03-02T09:55:21.627462Z","end":"2026-03-02T09:55:21.759479Z","steps":["trace[1828862946] 'process raft request' (duration: 131.619195ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:55:23.904525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.525565ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-02T09:55:23.904691Z","caller":"traceutil/trace.go:171","msg":"trace[2076512869] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"630.718255ms","start":"2026-03-02T09:55:23.273946Z","end":"2026-03-02T09:55:23.904665Z","steps":["trace[2076512869] 'process raft request' (duration: 355.92625ms)","trace[2076512869] 'compare' (duration: 274.143615ms)"],"step_count":2} {"level":"warn","ts":"2026-03-02T09:55:23.904766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:55:23.273922Z","time spent":"630.810675ms","remote":"127.0.0.1:57266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5153,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-02T09:55:23.918313Z","caller":"traceutil/trace.go:171","msg":"trace[604819703] linearizableReadLoop","detail":"{readStateIndex:587; appliedIndex:583; }","duration":"319.206859ms","start":"2026-03-02T09:55:23.599076Z","end":"2026-03-02T09:55:23.918283Z","steps":["trace[604819703] 'read index received' (duration: 30.803458ms)","trace[604819703] 'applied index is now lower than readState.Index' (duration: 288.402201ms)"],"step_count":2} {"level":"info","ts":"2026-03-02T09:55:23.918378Z","caller":"traceutil/trace.go:171","msg":"trace[184208852] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"632.467392ms","start":"2026-03-02T09:55:23.285867Z","end":"2026-03-02T09:55:23.918334Z","steps":["trace[184208852] 'process raft request' (duration: 632.280523ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:55:23.918439Z","caller":"traceutil/trace.go:171","msg":"trace[1781167329] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"464.735027ms","start":"2026-03-02T09:55:23.453689Z","end":"2026-03-02T09:55:23.918424Z","steps":["trace[1781167329] 'process raft request' (duration: 464.547658ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:55:23.918546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.451428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-02T09:55:23.918601Z","caller":"traceutil/trace.go:171","msg":"trace[1309268724] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:564; }","duration":"319.528018ms","start":"2026-03-02T09:55:23.599064Z","end":"2026-03-02T09:55:23.918592Z","steps":["trace[1309268724] 'agreement among raft nodes before linearized reading' (duration: 319.398948ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:55:23.918627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:55:23.599012Z","time spent":"319.607158ms","remote":"127.0.0.1:57228","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-03-02T09:55:23.918616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:55:23.28585Z","time spent":"632.629122ms","remote":"127.0.0.1:57448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-02T09:55:23.918628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:55:23.453657Z","time spent":"464.823466ms","remote":"127.0.0.1:57266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-02T09:55:23.918425Z","caller":"traceutil/trace.go:171","msg":"trace[793584174] transaction","detail":"{read_only:false; number_of_response:0; response_revision:562; }","duration":"644.16817ms","start":"2026-03-02T09:55:23.27424Z","end":"2026-03-02T09:55:23.918409Z","steps":["trace[793584174] 'process raft request' (duration: 643.817341ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:55:23.918761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:55:23.274228Z","time spent":"644.50677ms","remote":"127.0.0.1:57756","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-02T09:55:23.928021Z","caller":"traceutil/trace.go:171","msg":"trace[1269276862] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"275.481313ms","start":"2026-03-02T09:55:23.652501Z","end":"2026-03-02T09:55:23.927982Z","steps":["trace[1269276862] 'process raft request' (duration: 275.252353ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:55:23.928426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.709211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-02T09:55:23.92848Z","caller":"traceutil/trace.go:171","msg":"trace[307826747] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:567; }","duration":"172.823861ms","start":"2026-03-02T09:55:23.755638Z","end":"2026-03-02T09:55:23.928462Z","steps":["trace[307826747] 'agreement among raft nodes before linearized reading' (duration: 172.622591ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:55:23.928459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.483129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-03-02T09:55:23.928539Z","caller":"traceutil/trace.go:171","msg":"trace[156169376] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:567; }","duration":"164.625769ms","start":"2026-03-02T09:55:23.763894Z","end":"2026-03-02T09:55:23.928519Z","steps":["trace[156169376] 'agreement among raft nodes before linearized reading' (duration: 164.415219ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:55:23.928786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.645817ms","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-03-02T09:55:23.928825Z","caller":"traceutil/trace.go:171","msg":"trace[521394600] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:567; }","duration":"165.719487ms","start":"2026-03-02T09:55:23.763096Z","end":"2026-03-02T09:55:23.928816Z","steps":["trace[521394600] 'agreement among raft nodes before linearized reading' (duration: 165.625367ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:56:56.827291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.879942ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-02T09:56:56.827446Z","caller":"traceutil/trace.go:171","msg":"trace[258868059] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:998; }","duration":"127.072692ms","start":"2026-03-02T09:56:56.70034Z","end":"2026-03-02T09:56:56.827412Z","steps":["trace[258868059] 'range keys from in-memory index tree' (duration: 126.857481ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:56:56.842269Z","caller":"traceutil/trace.go:171","msg":"trace[518047321] linearizableReadLoop","detail":"{readStateIndex:1044; appliedIndex:1043; }","duration":"372.322168ms","start":"2026-03-02T09:56:56.469901Z","end":"2026-03-02T09:56:56.842223Z","steps":["trace[518047321] 'read index received' (duration: 372.006452ms)","trace[518047321] 'applied index is now lower than readState.Index' (duration: 314.336µs)"],"step_count":2} {"level":"info","ts":"2026-03-02T09:56:56.842303Z","caller":"traceutil/trace.go:171","msg":"trace[138290199] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"373.222944ms","start":"2026-03-02T09:56:56.469035Z","end":"2026-03-02T09:56:56.842258Z","steps":["trace[138290199] 'process raft request' (duration: 372.993602ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:56:56.842472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.546119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-02T09:56:56.8425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:56:56.46902Z","time spent":"373.369691ms","remote":"127.0.0.1:57448","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-03-02T09:56:56.842851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.787718ms","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-03-02T09:56:56.842819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.432202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-02T09:56:56.842956Z","caller":"traceutil/trace.go:171","msg":"trace[840871985] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:999; }","duration":"309.896934ms","start":"2026-03-02T09:56:56.53299Z","end":"2026-03-02T09:56:56.842887Z","steps":["trace[840871985] 'agreement among raft nodes before linearized reading' (duration: 309.62635ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:56:56.843004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:56:56.532977Z","time spent":"310.01732ms","remote":"127.0.0.1:57448","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-03-02T09:56:56.842928Z","caller":"traceutil/trace.go:171","msg":"trace[16269581] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:999; }","duration":"372.643444ms","start":"2026-03-02T09:56:56.469862Z","end":"2026-03-02T09:56:56.842505Z","steps":["trace[16269581] 'agreement among raft nodes before linearized reading' (duration: 372.533949ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:56:56.843066Z","caller":"traceutil/trace.go:171","msg":"trace[307176021] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:999; }","duration":"243.674384ms","start":"2026-03-02T09:56:56.599329Z","end":"2026-03-02T09:56:56.843004Z","steps":["trace[307176021] 'agreement among raft nodes before linearized reading' (duration: 243.332216ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T09:56:56.843195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T09:56:56.469845Z","time spent":"373.270286ms","remote":"127.0.0.1:57348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"warn","ts":"2026-03-02T09:56:56.843969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.321871ms","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-03-02T09:56:56.844037Z","caller":"traceutil/trace.go:171","msg":"trace[698262059] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:999; }","duration":"273.402035ms","start":"2026-03-02T09:56:56.570612Z","end":"2026-03-02T09:56:56.844014Z","steps":["trace[698262059] 'agreement among raft nodes before linearized reading' (duration: 272.198553ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:56:56.976541Z","caller":"traceutil/trace.go:171","msg":"trace[247829305] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"126.754986ms","start":"2026-03-02T09:56:56.849755Z","end":"2026-03-02T09:56:56.97651Z","steps":["trace[247829305] 'process raft request' (duration: 111.446888ms)","trace[247829305] 'compare' (duration: 15.115218ms)"],"step_count":2} {"level":"info","ts":"2026-03-02T09:56:57.065003Z","caller":"traceutil/trace.go:171","msg":"trace[1462936999] linearizableReadLoop","detail":"{readStateIndex:1046; appliedIndex:1044; }","duration":"211.232759ms","start":"2026-03-02T09:56:56.853741Z","end":"2026-03-02T09:56:57.064974Z","steps":["trace[1462936999] 'read index received' (duration: 107.439982ms)","trace[1462936999] 'applied index is now lower than readState.Index' (duration: 103.790847ms)"],"step_count":2} {"level":"warn","ts":"2026-03-02T09:56:57.065178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.411478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-02T09:56:57.065215Z","caller":"traceutil/trace.go:171","msg":"trace[1169944062] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1001; }","duration":"211.497032ms","start":"2026-03-02T09:56:56.853706Z","end":"2026-03-02T09:56:57.065203Z","steps":["trace[1169944062] 'agreement among raft nodes before linearized reading' (duration: 211.374286ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T09:56:57.06548Z","caller":"traceutil/trace.go:171","msg":"trace[287505430] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"215.298679ms","start":"2026-03-02T09:56:56.850144Z","end":"2026-03-02T09:56:57.065443Z","steps":["trace[287505430] 'process raft request' (duration: 214.683847ms)"],"step_count":1}