{"level":"warn","ts":"2026-02-25T02:07:29.830739Z","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:07:29.830849Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.250: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.250:2380","--initial-cluster=instance=https://199.204.45.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.250: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:07:29.830947Z","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:07:29.830958Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-02-25T02:07:29.830988Z","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:07:29.83193Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"]} {"level":"info","ts":"2026-02-25T02:07:29.832046Z","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.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.250: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:07:29.836336Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.056726ms"} {"level":"info","ts":"2026-02-25T02:07:29.842014Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d98d5f2c752cc52d","cluster-id":"c785b4aaf4bd3b11"} {"level":"info","ts":"2026-02-25T02:07:29.842274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=()"} {"level":"info","ts":"2026-02-25T02:07:29.842305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 0"} {"level":"info","ts":"2026-02-25T02:07:29.842316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d98d5f2c752cc52d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-25T02:07:29.842414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 1"} {"level":"info","ts":"2026-02-25T02:07:29.842467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"warn","ts":"2026-02-25T02:07:29.848385Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-25T02:07:29.849461Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-25T02:07:29.850469Z","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:07:29.852351Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d98d5f2c752cc52d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-25T02:07:29.857031Z","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:07:29.857103Z","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:07:29.857121Z","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:07:29.857243Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d98d5f2c752cc52d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-25T02:07:29.858552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"info","ts":"2026-02-25T02:07:29.858821Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","added-peer-id":"d98d5f2c752cc52d","added-peer-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-02-25T02:07:29.861041Z","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:07:29.861223Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-02-25T02:07:29.861241Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-02-25T02:07:29.861684Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d98d5f2c752cc52d","initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-25T02:07:29.861723Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-25T02:07:30.743293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d is starting a new election at term 1"} {"level":"info","ts":"2026-02-25T02:07:30.74336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became pre-candidate at term 1"} {"level":"info","ts":"2026-02-25T02:07:30.743394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgPreVoteResp from d98d5f2c752cc52d at term 1"} {"level":"info","ts":"2026-02-25T02:07:30.743413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became candidate at term 2"} {"level":"info","ts":"2026-02-25T02:07:30.743424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgVoteResp from d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-02-25T02:07:30.743439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became leader at term 2"} {"level":"info","ts":"2026-02-25T02:07:30.743453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d98d5f2c752cc52d elected leader d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-02-25T02:07:30.744474Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d98d5f2c752cc52d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.250:2379]}","request-path":"/0/members/d98d5f2c752cc52d/attributes","cluster-id":"c785b4aaf4bd3b11","publish-timeout":"7s"} {"level":"info","ts":"2026-02-25T02:07:30.744636Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T02:07:30.744672Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T02:07:30.744912Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T02:07:30.746783Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T02:07:30.747Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T02:07:30.747112Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T02:07:30.747416Z","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:07:30.748156Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.250:2379"} {"level":"info","ts":"2026-02-25T02:07:30.748282Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-25T02:07:30.749415Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-25T02:07:32.51875Z","caller":"traceutil/trace.go:171","msg":"trace[347210714] linearizableReadLoop","detail":"{readStateIndex:57; appliedIndex:54; }","duration":"129.320907ms","start":"2026-02-25T02:07:32.389391Z","end":"2026-02-25T02:07:32.518712Z","steps":["trace[347210714] 'read index received' (duration: 100.057047ms)","trace[347210714] 'applied index is now lower than readState.Index' (duration: 29.26291ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:07:32.518754Z","caller":"traceutil/trace.go:171","msg":"trace[1820291760] transaction","detail":"{read_only:false; response_revision:50; number_of_response:1; }","duration":"160.159218ms","start":"2026-02-25T02:07:32.358554Z","end":"2026-02-25T02:07:32.518713Z","steps":["trace[1820291760] 'process raft request' (duration: 131.1164ms)","trace[1820291760] 'compare' (duration: 28.769175ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:07:32.519043Z","caller":"traceutil/trace.go:171","msg":"trace[519158651] transaction","detail":"{read_only:false; response_revision:51; number_of_response:1; }","duration":"159.717553ms","start":"2026-02-25T02:07:32.359313Z","end":"2026-02-25T02:07:32.519031Z","steps":["trace[519158651] 'process raft request' (duration: 159.304267ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:07:32.519052Z","caller":"traceutil/trace.go:171","msg":"trace[83537733] transaction","detail":"{read_only:false; response_revision:52; number_of_response:1; }","duration":"159.201897ms","start":"2026-02-25T02:07:32.359819Z","end":"2026-02-25T02:07:32.519021Z","steps":["trace[83537733] 'process raft request' (duration: 158.846951ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:07:32.5192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.714672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T02:07:32.519276Z","caller":"traceutil/trace.go:171","msg":"trace[1336281909] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:52; }","duration":"129.904664ms","start":"2026-02-25T02:07:32.389354Z","end":"2026-02-25T02:07:32.519258Z","steps":["trace[1336281909] 'agreement among raft nodes before linearized reading' (duration: 129.717182ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:07:32.752706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.408646ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-02-25T02:07:32.752828Z","caller":"traceutil/trace.go:171","msg":"trace[1695180042] linearizableReadLoop","detail":"{readStateIndex:74; appliedIndex:73; }","duration":"130.98873ms","start":"2026-02-25T02:07:32.62182Z","end":"2026-02-25T02:07:32.752809Z","steps":["trace[1695180042] 'read index received' (duration: 7.772614ms)","trace[1695180042] 'applied index is now lower than readState.Index' (duration: 123.214786ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:07:32.752913Z","caller":"traceutil/trace.go:171","msg":"trace[63859354] transaction","detail":"{read_only:false; response_revision:69; number_of_response:1; }","duration":"155.507726ms","start":"2026-02-25T02:07:32.59733Z","end":"2026-02-25T02:07:32.752838Z","steps":["trace[63859354] 'process raft request' (duration: 32.28879ms)","trace[63859354] 'compare' (duration: 122.277873ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:07:32.753138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.310974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18975b320e202d7f\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-02-25T02:07:32.753185Z","caller":"traceutil/trace.go:171","msg":"trace[1638166582] range","detail":"{range_begin:/registry/events/default/instance.18975b320e202d7f; range_end:; response_count:1; response_revision:69; }","duration":"131.398474ms","start":"2026-02-25T02:07:32.621775Z","end":"2026-02-25T02:07:32.753173Z","steps":["trace[1638166582] 'agreement among raft nodes before linearized reading' (duration: 131.084411ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:07:33.913264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.04292831s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-25T02:07:33.913554Z","caller":"traceutil/trace.go:171","msg":"trace[1299996918] linearizableReadLoop","detail":"{readStateIndex:77; appliedIndex:74; }","duration":"913.962418ms","start":"2026-02-25T02:07:32.999568Z","end":"2026-02-25T02:07:33.91353Z","steps":["trace[1299996918] 'read index received' (duration: 295.231499ms)","trace[1299996918] 'applied index is now lower than readState.Index' (duration: 618.729449ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:07:33.913681Z","caller":"traceutil/trace.go:171","msg":"trace[1426623681] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"1.157994697s","start":"2026-02-25T02:07:32.755616Z","end":"2026-02-25T02:07:33.913611Z","steps":["trace[1426623681] 'process raft request' (duration: 1.157784644s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:07:33.914031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"913.761974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T02:07:33.913997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:07:32.755553Z","time spent":"1.158375881s","remote":"127.0.0.1:41136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T02:07:33.914111Z","caller":"traceutil/trace.go:171","msg":"trace[1399210485] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:72; }","duration":"913.828455ms","start":"2026-02-25T02:07:33.000237Z","end":"2026-02-25T02:07:33.914066Z","steps":["trace[1399210485] 'agreement among raft nodes before linearized reading' (duration: 913.740394ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:07:33.914045Z","caller":"traceutil/trace.go:171","msg":"trace[1950256190] transaction","detail":"{read_only:false; response_revision:70; number_of_response:1; }","duration":"1.289530643s","start":"2026-02-25T02:07:32.624461Z","end":"2026-02-25T02:07:33.913991Z","steps":["trace[1950256190] 'process raft request' (duration: 245.784733ms)","trace[1950256190] 'compare' (duration: 1.042762388s)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:07:33.914138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.866756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T02:07:33.914161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:07:33.000233Z","time spent":"913.914307ms","remote":"127.0.0.1:41424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"info","ts":"2026-02-25T02:07:33.914188Z","caller":"traceutil/trace.go:171","msg":"trace[866809500] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:72; }","duration":"810.930687ms","start":"2026-02-25T02:07:33.103239Z","end":"2026-02-25T02:07:33.914169Z","steps":["trace[866809500] 'agreement among raft nodes before linearized reading' (duration: 810.822365ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:07:33.914218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:07:33.103228Z","time spent":"810.984748ms","remote":"127.0.0.1:41040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-25T02:07:33.91422Z","caller":"traceutil/trace.go:171","msg":"trace[447554542] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"1.155472973s","start":"2026-02-25T02:07:32.758704Z","end":"2026-02-25T02:07:33.914177Z","steps":["trace[447554542] 'process raft request' (duration: 1.154777754s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:07:33.914245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:07:32.624432Z","time spent":"1.289740746s","remote":"127.0.0.1:41528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":565,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T02:07:33.914055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"914.441413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T02:07:33.914319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:07:32.75869Z","time spent":"1.155570064s","remote":"127.0.0.1:41516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1088,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T02:07:33.914445Z","caller":"traceutil/trace.go:171","msg":"trace[307153122] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:72; }","duration":"914.82014ms","start":"2026-02-25T02:07:32.999533Z","end":"2026-02-25T02:07:33.914353Z","steps":["trace[307153122] 'agreement among raft nodes before linearized reading' (duration: 914.389293ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:07:33.914627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:07:32.999512Z","time spent":"915.050332ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-02-25T02:07:34.353489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.366939ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-25T02:07:34.353743Z","caller":"traceutil/trace.go:171","msg":"trace[720514884] transaction","detail":"{read_only:false; response_revision:74; number_of_response:1; }","duration":"435.124173ms","start":"2026-02-25T02:07:33.918598Z","end":"2026-02-25T02:07:34.353722Z","steps":["trace[720514884] 'process raft request' (duration: 435.005531ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:07:34.353721Z","caller":"traceutil/trace.go:171","msg":"trace[89879900] transaction","detail":"{read_only:false; response_revision:73; number_of_response:1; }","duration":"435.090512ms","start":"2026-02-25T02:07:33.91852Z","end":"2026-02-25T02:07:34.353611Z","steps":["trace[89879900] 'process raft request' (duration: 259.519231ms)","trace[89879900] 'compare' (duration: 175.184537ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:07:34.353914Z","caller":"traceutil/trace.go:171","msg":"trace[299014875] transaction","detail":"{read_only:false; response_revision:75; number_of_response:1; }","duration":"435.167335ms","start":"2026-02-25T02:07:33.918738Z","end":"2026-02-25T02:07:34.353906Z","steps":["trace[299014875] 'process raft request' (duration: 434.932911ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:07:34.353964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:07:33.918635Z","time spent":"435.310706ms","remote":"127.0.0.1:41516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":581,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T02:07:34.354157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:07:33.918501Z","time spent":"435.435128ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T02:07:34.354201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.564629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18975b320e203f81\" ","response":"range_response_count:1 size:648"} {"level":"info","ts":"2026-02-25T02:07:34.354283Z","caller":"traceutil/trace.go:171","msg":"trace[443385118] range","detail":"{range_begin:/registry/events/default/instance.18975b320e203f81; range_end:; response_count:1; response_revision:75; }","duration":"435.678881ms","start":"2026-02-25T02:07:33.918585Z","end":"2026-02-25T02:07:34.354264Z","steps":["trace[443385118] 'agreement among raft nodes before linearized reading' (duration: 435.270646ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:07:34.353785Z","caller":"traceutil/trace.go:171","msg":"trace[1837327480] linearizableReadLoop","detail":"{readStateIndex:78; appliedIndex:77; }","duration":"435.145594ms","start":"2026-02-25T02:07:33.918609Z","end":"2026-02-25T02:07:34.353755Z","steps":["trace[1837327480] 'read index received' (duration: 259.44168ms)","trace[1837327480] 'applied index is now lower than readState.Index' (duration: 175.701104ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:07:34.354338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:07:33.918574Z","time spent":"435.755302ms","remote":"127.0.0.1:41136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":672,"request content":"key:\"/registry/events/default/instance.18975b320e203f81\" "} {"level":"warn","ts":"2026-02-25T02:07:34.353833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:07:33.918572Z","time spent":"435.216305ms","remote":"127.0.0.1:41516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1121,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T02:07:34.354486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.85348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T02:07:34.354529Z","caller":"traceutil/trace.go:171","msg":"trace[282846234] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:75; }","duration":"434.935582ms","start":"2026-02-25T02:07:33.91958Z","end":"2026-02-25T02:07:34.354516Z","steps":["trace[282846234] 'agreement among raft nodes before linearized reading' (duration: 434.876921ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:07:34.354535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.565836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T02:07:34.354559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:07:33.91956Z","time spent":"434.993452ms","remote":"127.0.0.1:41424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/system:aggregate-to-admin\" "} {"level":"info","ts":"2026-02-25T02:07:34.354575Z","caller":"traceutil/trace.go:171","msg":"trace[1604754496] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:75; }","duration":"222.606446ms","start":"2026-02-25T02:07:34.131959Z","end":"2026-02-25T02:07:34.354565Z","steps":["trace[1604754496] 'agreement among raft nodes before linearized reading' (duration: 222.540136ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:07:34.354698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.70656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T02:07:34.354734Z","caller":"traceutil/trace.go:171","msg":"trace[1873927845] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:75; }","duration":"249.860052ms","start":"2026-02-25T02:07:34.104864Z","end":"2026-02-25T02:07:34.354724Z","steps":["trace[1873927845] 'agreement among raft nodes before linearized reading' (duration: 249.805822ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:07:34.354878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.700843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T02:07:34.354914Z","caller":"traceutil/trace.go:171","msg":"trace[317096000] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:75; }","duration":"414.758604ms","start":"2026-02-25T02:07:33.940145Z","end":"2026-02-25T02:07:34.354903Z","steps":["trace[317096000] 'agreement among raft nodes before linearized reading' (duration: 414.696424ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:07:34.35494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:07:33.940133Z","time spent":"414.800315ms","remote":"127.0.0.1:41196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"info","ts":"2026-02-25T02:07:37.451509Z","caller":"traceutil/trace.go:171","msg":"trace[913887359] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"112.204387ms","start":"2026-02-25T02:07:37.339267Z","end":"2026-02-25T02:07:37.451472Z","steps":["trace[913887359] 'process raft request' (duration: 54.025132ms)","trace[913887359] 'compare' (duration: 57.832311ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:07:40.802515Z","caller":"traceutil/trace.go:171","msg":"trace[238378328] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"114.346881ms","start":"2026-02-25T02:07:40.688141Z","end":"2026-02-25T02:07:40.802488Z","steps":["trace[238378328] 'process raft request' (duration: 23.933313ms)","trace[238378328] 'compare' (duration: 90.223136ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:07:40.80276Z","caller":"traceutil/trace.go:171","msg":"trace[338601107] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"114.574514ms","start":"2026-02-25T02:07:40.688167Z","end":"2026-02-25T02:07:40.802742Z","steps":["trace[338601107] 'process raft request' (duration: 114.252901ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:07:40.803048Z","caller":"traceutil/trace.go:171","msg":"trace[1240250792] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"109.206089ms","start":"2026-02-25T02:07:40.693671Z","end":"2026-02-25T02:07:40.802877Z","steps":["trace[1240250792] 'process raft request' (duration: 109.078627ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:07:40.803245Z","caller":"traceutil/trace.go:171","msg":"trace[1555299071] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"114.063048ms","start":"2026-02-25T02:07:40.689169Z","end":"2026-02-25T02:07:40.803232Z","steps":["trace[1555299071] 'process raft request' (duration: 113.482641ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:07:40.80335Z","caller":"traceutil/trace.go:171","msg":"trace[975670373] linearizableReadLoop","detail":"{readStateIndex:355; appliedIndex:352; }","duration":"111.528507ms","start":"2026-02-25T02:07:40.691809Z","end":"2026-02-25T02:07:40.803337Z","steps":["trace[975670373] 'read index received' (duration: 20.217427ms)","trace[975670373] 'applied index is now lower than readState.Index' (duration: 91.309669ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:07:40.803473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.980922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-25T02:07:40.803518Z","caller":"traceutil/trace.go:171","msg":"trace[1175012694] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:346; }","duration":"138.051392ms","start":"2026-02-25T02:07:40.66545Z","end":"2026-02-25T02:07:40.803501Z","steps":["trace[1175012694] 'agreement among raft nodes before linearized reading' (duration: 137.969981ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:07:41.193082Z","caller":"traceutil/trace.go:171","msg":"trace[1653769948] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"112.396356ms","start":"2026-02-25T02:07:41.080652Z","end":"2026-02-25T02:07:41.193048Z","steps":["trace[1653769948] 'process raft request' (duration: 75.869032ms)","trace[1653769948] 'compare' (duration: 36.352712ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:07:41.199588Z","caller":"traceutil/trace.go:171","msg":"trace[1844948518] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"115.711115ms","start":"2026-02-25T02:07:41.083852Z","end":"2026-02-25T02:07:41.199563Z","steps":["trace[1844948518] 'process raft request' (duration: 115.632554ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:07:41.199845Z","caller":"traceutil/trace.go:171","msg":"trace[2093693540] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"117.020111ms","start":"2026-02-25T02:07:41.08278Z","end":"2026-02-25T02:07:41.1998Z","steps":["trace[2093693540] 'process raft request' (duration: 116.573836ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:07:41.319108Z","caller":"traceutil/trace.go:171","msg":"trace[1050616618] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"112.351124ms","start":"2026-02-25T02:07:41.206721Z","end":"2026-02-25T02:07:41.319072Z","steps":["trace[1050616618] 'process raft request' (duration: 102.190401ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:07:41.319141Z","caller":"traceutil/trace.go:171","msg":"trace[705957677] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"110.527242ms","start":"2026-02-25T02:07:41.20858Z","end":"2026-02-25T02:07:41.319107Z","steps":["trace[705957677] 'process raft request' (duration: 110.3806ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:07:41.319406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.551853ms","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:07:41.3196Z","caller":"traceutil/trace.go:171","msg":"trace[851349166] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:365; }","duration":"106.779136ms","start":"2026-02-25T02:07:41.212733Z","end":"2026-02-25T02:07:41.319512Z","steps":["trace[851349166] 'agreement among raft nodes before linearized reading' (duration: 106.417172ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:07:41.500846Z","caller":"traceutil/trace.go:171","msg":"trace[49889235] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"139.343981ms","start":"2026-02-25T02:07:41.361475Z","end":"2026-02-25T02:07:41.500819Z","steps":["trace[49889235] 'process raft request' (duration: 135.167601ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:07:41.501252Z","caller":"traceutil/trace.go:171","msg":"trace[1705284005] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"138.839856ms","start":"2026-02-25T02:07:41.362385Z","end":"2026-02-25T02:07:41.501225Z","steps":["trace[1705284005] 'process raft request' (duration: 138.3841ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:07:41.501479Z","caller":"traceutil/trace.go:171","msg":"trace[687972074] linearizableReadLoop","detail":"{readStateIndex:383; appliedIndex:377; }","duration":"138.486111ms","start":"2026-02-25T02:07:41.362976Z","end":"2026-02-25T02:07:41.501463Z","steps":["trace[687972074] 'read index received' (duration: 40.152838ms)","trace[687972074] 'applied index is now lower than readState.Index' (duration: 98.332343ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:07:41.501686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.690434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-25T02:07:41.501768Z","caller":"traceutil/trace.go:171","msg":"trace[1022383019] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:374; }","duration":"138.809496ms","start":"2026-02-25T02:07:41.362944Z","end":"2026-02-25T02:07:41.501754Z","steps":["trace[1022383019] 'agreement among raft nodes before linearized reading' (duration: 138.660835ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:07:41.501752Z","caller":"traceutil/trace.go:171","msg":"trace[483709240] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"139.123549ms","start":"2026-02-25T02:07:41.362601Z","end":"2026-02-25T02:07:41.501725Z","steps":["trace[483709240] 'process raft request' (duration: 138.676563ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:07:41.501849Z","caller":"traceutil/trace.go:171","msg":"trace[442842523] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"139.318821ms","start":"2026-02-25T02:07:41.362507Z","end":"2026-02-25T02:07:41.501826Z","steps":["trace[442842523] 'process raft request' (duration: 138.636463ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:07:41.688404Z","caller":"traceutil/trace.go:171","msg":"trace[1286186009] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"179.445899ms","start":"2026-02-25T02:07:41.508931Z","end":"2026-02-25T02:07:41.688377Z","steps":["trace[1286186009] 'process raft request' (duration: 122.079502ms)","trace[1286186009] 'compare' (duration: 57.167575ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:07:41.688929Z","caller":"traceutil/trace.go:171","msg":"trace[1598707314] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"176.662274ms","start":"2026-02-25T02:07:41.512239Z","end":"2026-02-25T02:07:41.688902Z","steps":["trace[1598707314] 'process raft request' (duration: 176.518593ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:07:41.688966Z","caller":"traceutil/trace.go:171","msg":"trace[1794269298] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"178.202593ms","start":"2026-02-25T02:07:41.510745Z","end":"2026-02-25T02:07:41.688948Z","steps":["trace[1794269298] 'process raft request' (duration: 177.576865ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:08:02.772646Z","caller":"traceutil/trace.go:171","msg":"trace[392802278] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"189.493263ms","start":"2026-02-25T02:08:02.583135Z","end":"2026-02-25T02:08:02.772628Z","steps":["trace[392802278] 'process raft request' (duration: 189.375721ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:08:07.065811Z","caller":"traceutil/trace.go:171","msg":"trace[1389887347] linearizableReadLoop","detail":"{readStateIndex:564; appliedIndex:563; }","duration":"260.709618ms","start":"2026-02-25T02:08:06.805082Z","end":"2026-02-25T02:08:07.065791Z","steps":["trace[1389887347] 'read index received' (duration: 260.580937ms)","trace[1389887347] 'applied index is now lower than readState.Index' (duration: 128.041µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:08:07.065851Z","caller":"traceutil/trace.go:171","msg":"trace[713188334] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"278.478398ms","start":"2026-02-25T02:08:06.787342Z","end":"2026-02-25T02:08:07.065821Z","steps":["trace[713188334] 'process raft request' (duration: 278.287776ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:08:07.065947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.82861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:08:07.065972Z","caller":"traceutil/trace.go:171","msg":"trace[764680273] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:548; }","duration":"260.929391ms","start":"2026-02-25T02:08:06.805036Z","end":"2026-02-25T02:08:07.065965Z","steps":["trace[764680273] 'agreement among raft nodes before linearized reading' (duration: 260.84407ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:08:08.390196Z","caller":"traceutil/trace.go:171","msg":"trace[2053510277] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"129.188435ms","start":"2026-02-25T02:08:08.260979Z","end":"2026-02-25T02:08:08.390167Z","steps":["trace[2053510277] 'process raft request' (duration: 128.994923ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:08:09.336152Z","caller":"traceutil/trace.go:171","msg":"trace[1420644302] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:572; }","duration":"249.218277ms","start":"2026-02-25T02:08:09.08691Z","end":"2026-02-25T02:08:09.336128Z","steps":["trace[1420644302] 'read index received' (duration: 249.104436ms)","trace[1420644302] 'applied index is now lower than readState.Index' (duration: 112.801µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:08:09.336204Z","caller":"traceutil/trace.go:171","msg":"trace[378756032] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"263.123445ms","start":"2026-02-25T02:08:09.07305Z","end":"2026-02-25T02:08:09.336174Z","steps":["trace[378756032] 'process raft request' (duration: 262.945273ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:08:09.336359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.43417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-02-25T02:08:09.336394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.999837ms","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-02-25T02:08:09.336419Z","caller":"traceutil/trace.go:171","msg":"trace[2079831373] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:557; }","duration":"249.523831ms","start":"2026-02-25T02:08:09.086875Z","end":"2026-02-25T02:08:09.336399Z","steps":["trace[2079831373] 'agreement among raft nodes before linearized reading' (duration: 249.349688ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:08:09.336451Z","caller":"traceutil/trace.go:171","msg":"trace[1815009498] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:557; }","duration":"171.104728ms","start":"2026-02-25T02:08:09.165322Z","end":"2026-02-25T02:08:09.336426Z","steps":["trace[1815009498] 'agreement among raft nodes before linearized reading' (duration: 170.940296ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:08:10.006968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.59815ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T02:08:10.007412Z","caller":"traceutil/trace.go:171","msg":"trace[441663237] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"666.451921ms","start":"2026-02-25T02:08:09.340931Z","end":"2026-02-25T02:08:10.007383Z","steps":["trace[441663237] 'process raft request' (duration: 666.33439ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:08:10.00746Z","caller":"traceutil/trace.go:171","msg":"trace[1080813584] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"666.821074ms","start":"2026-02-25T02:08:09.340623Z","end":"2026-02-25T02:08:10.007444Z","steps":["trace[1080813584] 'process raft request' (duration: 354.581488ms)","trace[1080813584] 'compare' (duration: 311.196466ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:08:10.007543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:08:09.340602Z","time spent":"666.903225ms","remote":"127.0.0.1:41336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T02:08:10.007574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:08:09.340896Z","time spent":"666.597762ms","remote":"127.0.0.1:41336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T02:08:10.007702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.969858ms","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:08:10.007761Z","caller":"traceutil/trace.go:171","msg":"trace[1451274772] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:559; }","duration":"563.06644ms","start":"2026-02-25T02:08:09.44468Z","end":"2026-02-25T02:08:10.007747Z","steps":["trace[1451274772] 'agreement among raft nodes before linearized reading' (duration: 562.914258ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:08:10.00779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:08:09.44466Z","time spent":"563.12542ms","remote":"127.0.0.1:41336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-25T02:08:10.007365Z","caller":"traceutil/trace.go:171","msg":"trace[1131717714] linearizableReadLoop","detail":"{readStateIndex:575; appliedIndex:573; }","duration":"562.630094ms","start":"2026-02-25T02:08:09.444717Z","end":"2026-02-25T02:08:10.007347Z","steps":["trace[1131717714] 'read index received' (duration: 250.500829ms)","trace[1131717714] 'applied index is now lower than readState.Index' (duration: 312.128385ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:08:10.00851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.468111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:08:10.008544Z","caller":"traceutil/trace.go:171","msg":"trace[917356943] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:559; }","duration":"205.538052ms","start":"2026-02-25T02:08:09.802997Z","end":"2026-02-25T02:08:10.008535Z","steps":["trace[917356943] 'agreement among raft nodes before linearized reading' (duration: 205.485821ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:08:11.644592Z","caller":"traceutil/trace.go:171","msg":"trace[643515674] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"108.020749ms","start":"2026-02-25T02:08:11.536546Z","end":"2026-02-25T02:08:11.644567Z","steps":["trace[643515674] 'process raft request' (duration: 107.894418ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:08:56.415035Z","caller":"traceutil/trace.go:171","msg":"trace[1024516790] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"153.439803ms","start":"2026-02-25T02:08:56.261579Z","end":"2026-02-25T02:08:56.415019Z","steps":["trace[1024516790] 'process raft request' (duration: 153.35468ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:08:56.441752Z","caller":"traceutil/trace.go:171","msg":"trace[1052447624] transaction","detail":"{read_only:false; response_revision:841; number_of_response:1; }","duration":"179.742645ms","start":"2026-02-25T02:08:56.26199Z","end":"2026-02-25T02:08:56.441733Z","steps":["trace[1052447624] 'process raft request' (duration: 179.655892ms)"],"step_count":1}