{"level":"warn","ts":"2026-02-13T22:40:57.674726Z","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-13T22:40:57.674821Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.140: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://162.253.55.140:2380","--initial-cluster=instance=https://162.253.55.140:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.140:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.140: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-13T22:40:57.675134Z","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-13T22:40:57.675158Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.140:2380"]} {"level":"info","ts":"2026-02-13T22:40:57.677501Z","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-13T22:40:57.678196Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"]} {"level":"info","ts":"2026-02-13T22:40:57.678351Z","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":2,"max-cpu-available":2,"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://162.253.55.140:2380"],"listen-peer-urls":["https://162.253.55.140:2380"],"advertise-client-urls":["https://162.253.55.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.140: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-13T22:40:57.685992Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.000845ms"} {"level":"info","ts":"2026-02-13T22:40:57.720095Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf809824ab95ac81","cluster-id":"6f89f5fbef18dc61"} {"level":"info","ts":"2026-02-13T22:40:57.720335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=()"} {"level":"info","ts":"2026-02-13T22:40:57.72035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 0"} {"level":"info","ts":"2026-02-13T22:40:57.72036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf809824ab95ac81 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-13T22:40:57.720366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 1"} {"level":"info","ts":"2026-02-13T22:40:57.720572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"} {"level":"warn","ts":"2026-02-13T22:40:57.737789Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-13T22:40:57.745397Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-13T22:40:57.757775Z","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-13T22:40:57.765127Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf809824ab95ac81","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-13T22:40:57.776162Z","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-13T22:40:57.776492Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf809824ab95ac81","initial-advertise-peer-urls":["https://162.253.55.140:2380"],"listen-peer-urls":["https://162.253.55.140:2380"],"advertise-client-urls":["https://162.253.55.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-13T22:40:57.776518Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-13T22:40:57.776583Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.140:2380"} {"level":"info","ts":"2026-02-13T22:40:57.776598Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.140:2380"} {"level":"info","ts":"2026-02-13T22:40:57.77898Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf809824ab95ac81","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-13T22:40:57.779175Z","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-13T22:40:57.779206Z","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-13T22:40:57.779214Z","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-13T22:40:57.784564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"} {"level":"info","ts":"2026-02-13T22:40:57.784661Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6f89f5fbef18dc61","local-member-id":"cf809824ab95ac81","added-peer-id":"cf809824ab95ac81","added-peer-peer-urls":["https://162.253.55.140:2380"]} {"level":"info","ts":"2026-02-13T22:40:58.62184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 is starting a new election at term 1"} {"level":"info","ts":"2026-02-13T22:40:58.621887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-13T22:40:58.621905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgPreVoteResp from cf809824ab95ac81 at term 1"} {"level":"info","ts":"2026-02-13T22:40:58.621923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became candidate at term 2"} {"level":"info","ts":"2026-02-13T22:40:58.621929Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgVoteResp from cf809824ab95ac81 at term 2"} {"level":"info","ts":"2026-02-13T22:40:58.621937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became leader at term 2"} {"level":"info","ts":"2026-02-13T22:40:58.621945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf809824ab95ac81 elected leader cf809824ab95ac81 at term 2"} {"level":"info","ts":"2026-02-13T22:40:58.623496Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T22:40:58.625963Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf809824ab95ac81","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.140:2379]}","request-path":"/0/members/cf809824ab95ac81/attributes","cluster-id":"6f89f5fbef18dc61","publish-timeout":"7s"} {"level":"info","ts":"2026-02-13T22:40:58.626098Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-13T22:40:58.626398Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-13T22:40:58.626534Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-13T22:40:58.626543Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-13T22:40:58.626657Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6f89f5fbef18dc61","local-member-id":"cf809824ab95ac81","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T22:40:58.626715Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T22:40:58.626727Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T22:40:58.627959Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.140:2379"} {"level":"info","ts":"2026-02-13T22:40:58.629537Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-13T22:41:09.73629Z","caller":"traceutil/trace.go:171","msg":"trace[264983436] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"284.257803ms","start":"2026-02-13T22:41:09.451998Z","end":"2026-02-13T22:41:09.736256Z","steps":["trace[264983436] 'process raft request' (duration: 284.054716ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:10.221003Z","caller":"traceutil/trace.go:171","msg":"trace[1496875883] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"468.123148ms","start":"2026-02-13T22:41:09.752849Z","end":"2026-02-13T22:41:10.220972Z","steps":["trace[1496875883] 'process raft request' (duration: 461.164844ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:10.221959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:09.7526Z","time spent":"468.512952ms","remote":"127.0.0.1:39442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2881,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T22:41:10.222321Z","caller":"traceutil/trace.go:171","msg":"trace[226452973] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"466.556132ms","start":"2026-02-13T22:41:09.75575Z","end":"2026-02-13T22:41:10.222306Z","steps":["trace[226452973] 'process raft request' (duration: 463.765635ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:10.222535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:09.755743Z","time spent":"466.608244ms","remote":"127.0.0.1:39146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6883,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T22:41:16.180576Z","caller":"traceutil/trace.go:171","msg":"trace[643102760] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"218.523005ms","start":"2026-02-13T22:41:15.962028Z","end":"2026-02-13T22:41:16.180551Z","steps":["trace[643102760] 'process raft request' (duration: 218.329469ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:16.433687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.485268ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-13T22:41:16.434205Z","caller":"traceutil/trace.go:171","msg":"trace[46003626] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"245.684547ms","start":"2026-02-13T22:41:16.188496Z","end":"2026-02-13T22:41:16.43418Z","steps":["trace[46003626] 'process raft request' (duration: 110.559897ms)","trace[46003626] 'compare' (duration: 134.385335ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:41:16.651905Z","caller":"traceutil/trace.go:171","msg":"trace[1045000099] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"201.35781ms","start":"2026-02-13T22:41:16.45053Z","end":"2026-02-13T22:41:16.651888Z","steps":["trace[1045000099] 'process raft request' (duration: 201.323609ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:16.652294Z","caller":"traceutil/trace.go:171","msg":"trace[1587733298] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"203.233513ms","start":"2026-02-13T22:41:16.449052Z","end":"2026-02-13T22:41:16.652286Z","steps":["trace[1587733298] 'process raft request' (duration: 162.998799ms)","trace[1587733298] 'compare' (duration: 39.617733ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:41:16.652381Z","caller":"traceutil/trace.go:171","msg":"trace[1908602415] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"203.280133ms","start":"2026-02-13T22:41:16.449094Z","end":"2026-02-13T22:41:16.652374Z","steps":["trace[1908602415] 'process raft request' (duration: 202.673043ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:16.652524Z","caller":"traceutil/trace.go:171","msg":"trace[1563810576] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"202.500839ms","start":"2026-02-13T22:41:16.450017Z","end":"2026-02-13T22:41:16.652518Z","steps":["trace[1563810576] 'process raft request' (duration: 201.780125ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:16.6526Z","caller":"traceutil/trace.go:171","msg":"trace[1768087850] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"202.096154ms","start":"2026-02-13T22:41:16.450498Z","end":"2026-02-13T22:41:16.652594Z","steps":["trace[1768087850] 'process raft request' (duration: 201.331859ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:16.977348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.49773ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T22:41:16.977685Z","caller":"traceutil/trace.go:171","msg":"trace[2042496203] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"315.576368ms","start":"2026-02-13T22:41:16.662079Z","end":"2026-02-13T22:41:16.977655Z","steps":["trace[2042496203] 'process raft request' (duration: 172.693575ms)","trace[2042496203] 'compare' (duration: 142.347616ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:41:16.97786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:16.662061Z","time spent":"315.682572ms","remote":"127.0.0.1:39448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3782,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T22:41:16.978031Z","caller":"traceutil/trace.go:171","msg":"trace[269689517] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"315.336261ms","start":"2026-02-13T22:41:16.662682Z","end":"2026-02-13T22:41:16.978018Z","steps":["trace[269689517] 'process raft request' (duration: 314.767302ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:16.978078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:16.662663Z","time spent":"315.390812ms","remote":"127.0.0.1:39040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T22:41:16.978365Z","caller":"traceutil/trace.go:171","msg":"trace[1979414296] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"313.423488ms","start":"2026-02-13T22:41:16.66493Z","end":"2026-02-13T22:41:16.978354Z","steps":["trace[1979414296] 'process raft request' (duration: 312.57777ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:16.978419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:16.664924Z","time spent":"313.464469ms","remote":"127.0.0.1:39146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4015,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T22:41:16.978625Z","caller":"traceutil/trace.go:171","msg":"trace[691793357] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"313.50148ms","start":"2026-02-13T22:41:16.665114Z","end":"2026-02-13T22:41:16.978615Z","steps":["trace[691793357] 'process raft request' (duration: 312.431546ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:16.978677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:16.665109Z","time spent":"313.539401ms","remote":"127.0.0.1:39448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3773,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T22:41:16.978875Z","caller":"traceutil/trace.go:171","msg":"trace[1131293241] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"313.718297ms","start":"2026-02-13T22:41:16.665147Z","end":"2026-02-13T22:41:16.978865Z","steps":["trace[1131293241] 'process raft request' (duration: 312.436106ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:16.978939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:16.665143Z","time spent":"313.753588ms","remote":"127.0.0.1:39040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-13T22:41:17.097211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.586337ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-13T22:41:17.097285Z","caller":"traceutil/trace.go:171","msg":"trace[45549730] linearizableReadLoop","detail":"{readStateIndex:455; appliedIndex:449; }","duration":"281.268994ms","start":"2026-02-13T22:41:16.816003Z","end":"2026-02-13T22:41:17.097272Z","steps":["trace[45549730] 'read index received' (duration: 18.870856ms)","trace[45549730] 'applied index is now lower than readState.Index' (duration: 262.397238ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:41:17.0975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.502841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-13T22:41:17.097722Z","caller":"traceutil/trace.go:171","msg":"trace[1379951366] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:439; }","duration":"281.767531ms","start":"2026-02-13T22:41:16.815938Z","end":"2026-02-13T22:41:17.097706Z","steps":["trace[1379951366] 'agreement among raft nodes before linearized reading' (duration: 281.499021ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:17.098167Z","caller":"traceutil/trace.go:171","msg":"trace[202696310] transaction","detail":"{read_only:false; number_of_response:1; response_revision:439; }","duration":"103.847505ms","start":"2026-02-13T22:41:16.994307Z","end":"2026-02-13T22:41:17.098154Z","steps":["trace[202696310] 'process raft request' (duration: 103.784903ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:17.12999Z","caller":"traceutil/trace.go:171","msg":"trace[319767374] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"135.487745ms","start":"2026-02-13T22:41:16.994484Z","end":"2026-02-13T22:41:17.129971Z","steps":["trace[319767374] 'process raft request' (duration: 135.364782ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:17.130248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.680912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4173"} {"level":"info","ts":"2026-02-13T22:41:17.130268Z","caller":"traceutil/trace.go:171","msg":"trace[1940671822] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:440; }","duration":"135.713673ms","start":"2026-02-13T22:41:16.994549Z","end":"2026-02-13T22:41:17.130262Z","steps":["trace[1940671822] 'agreement among raft nodes before linearized reading' (duration: 135.6424ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:17.130364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.496821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-tqrkf\" ","response":"range_response_count:1 size:3994"} {"level":"info","ts":"2026-02-13T22:41:17.130378Z","caller":"traceutil/trace.go:171","msg":"trace[485543705] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-tqrkf; range_end:; response_count:1; response_revision:440; }","duration":"141.543332ms","start":"2026-02-13T22:41:16.988829Z","end":"2026-02-13T22:41:17.130372Z","steps":["trace[485543705] 'agreement among raft nodes before linearized reading' (duration: 141.515721ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:17.250737Z","caller":"traceutil/trace.go:171","msg":"trace[290871227] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"114.272118ms","start":"2026-02-13T22:41:17.136447Z","end":"2026-02-13T22:41:17.250719Z","steps":["trace[290871227] 'process raft request' (duration: 114.229856ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:17.251052Z","caller":"traceutil/trace.go:171","msg":"trace[1968711630] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"119.439054ms","start":"2026-02-13T22:41:17.131606Z","end":"2026-02-13T22:41:17.251045Z","steps":["trace[1968711630] 'process raft request' (duration: 118.971709ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:20.904937Z","caller":"traceutil/trace.go:171","msg":"trace[1781808102] linearizableReadLoop","detail":"{readStateIndex:482; appliedIndex:481; }","duration":"237.046171ms","start":"2026-02-13T22:41:20.667867Z","end":"2026-02-13T22:41:20.904913Z","steps":["trace[1781808102] 'read index received' (duration: 236.818614ms)","trace[1781808102] 'applied index is now lower than readState.Index' (duration: 226.267µs)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:41:20.905325Z","caller":"traceutil/trace.go:171","msg":"trace[1045705330] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"428.770717ms","start":"2026-02-13T22:41:20.476527Z","end":"2026-02-13T22:41:20.905297Z","steps":["trace[1045705330] 'process raft request' (duration: 428.22924ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:20.905467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:20.476516Z","time spent":"428.87589ms","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T22:41:20.905599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.733312ms","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-13T22:41:20.905617Z","caller":"traceutil/trace.go:171","msg":"trace[1436934919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:464; }","duration":"237.789935ms","start":"2026-02-13T22:41:20.66782Z","end":"2026-02-13T22:41:20.90561Z","steps":["trace[1436934919] 'agreement among raft nodes before linearized reading' (duration: 237.735483ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:20.905676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.546098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-13T22:41:20.905686Z","caller":"traceutil/trace.go:171","msg":"trace[293144642] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:464; }","duration":"222.567679ms","start":"2026-02-13T22:41:20.683115Z","end":"2026-02-13T22:41:20.905683Z","steps":["trace[293144642] 'agreement among raft nodes before linearized reading' (duration: 222.545178ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:21.708924Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430388353291746305,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T22:41:22.412583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"668.703814ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T22:41:22.412761Z","caller":"traceutil/trace.go:171","msg":"trace[1206829186] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"1.502364839s","start":"2026-02-13T22:41:20.910372Z","end":"2026-02-13T22:41:22.412737Z","steps":["trace[1206829186] 'process raft request' (duration: 833.279354ms)","trace[1206829186] 'compare' (duration: 668.58837ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:41:22.412823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:20.910351Z","time spent":"1.502445502s","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T22:41:22.413446Z","caller":"traceutil/trace.go:171","msg":"trace[1252741055] linearizableReadLoop","detail":"{readStateIndex:485; appliedIndex:482; }","duration":"1.204905102s","start":"2026-02-13T22:41:21.208531Z","end":"2026-02-13T22:41:22.413436Z","steps":["trace[1252741055] 'read index received' (duration: 535.155787ms)","trace[1252741055] 'applied index is now lower than readState.Index' (duration: 669.748695ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:41:22.413619Z","caller":"traceutil/trace.go:171","msg":"trace[811591682] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"1.503008229s","start":"2026-02-13T22:41:20.910601Z","end":"2026-02-13T22:41:22.413609Z","steps":["trace[811591682] 'process raft request' (duration: 1.502103451s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:22.413661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:20.910589Z","time spent":"1.50304623s","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T22:41:22.413774Z","caller":"traceutil/trace.go:171","msg":"trace[487887372] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"1.457625492s","start":"2026-02-13T22:41:20.95614Z","end":"2026-02-13T22:41:22.413765Z","steps":["trace[487887372] 'process raft request' (duration: 1.457257561s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:22.413812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:20.956117Z","time spent":"1.457672924s","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T22:41:22.414022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.205457449s","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-13T22:41:22.414114Z","caller":"traceutil/trace.go:171","msg":"trace[329650733] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:467; }","duration":"1.205591673s","start":"2026-02-13T22:41:21.208498Z","end":"2026-02-13T22:41:22.414089Z","steps":["trace[329650733] 'agreement among raft nodes before linearized reading' (duration: 1.205402267s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:22.414159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:21.208482Z","time spent":"1.205668005s","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-13T22:41:22.414237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"983.214595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T22:41:22.414283Z","caller":"traceutil/trace.go:171","msg":"trace[1542743131] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:467; }","duration":"983.259737ms","start":"2026-02-13T22:41:21.431013Z","end":"2026-02-13T22:41:22.414273Z","steps":["trace[1542743131] 'agreement among raft nodes before linearized reading' (duration: 983.192095ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:22.414307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:21.43098Z","time spent":"983.322429ms","remote":"127.0.0.1:41750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-13T22:41:22.41451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"805.814517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.140\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-13T22:41:22.414535Z","caller":"traceutil/trace.go:171","msg":"trace[2008844299] range","detail":"{range_begin:/registry/masterleases/162.253.55.140; range_end:; response_count:1; response_revision:467; }","duration":"805.844737ms","start":"2026-02-13T22:41:21.608681Z","end":"2026-02-13T22:41:22.414525Z","steps":["trace[2008844299] 'agreement among raft nodes before linearized reading' (duration: 805.758585ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:22.414554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:21.60864Z","time spent":"805.90813ms","remote":"127.0.0.1:38986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.140\" "} {"level":"info","ts":"2026-02-13T22:41:23.088075Z","caller":"traceutil/trace.go:171","msg":"trace[741330695] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"176.745581ms","start":"2026-02-13T22:41:22.911311Z","end":"2026-02-13T22:41:23.088056Z","steps":["trace[741330695] 'process raft request' (duration: 176.571556ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:27.929086Z","caller":"traceutil/trace.go:171","msg":"trace[839932918] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"131.488208ms","start":"2026-02-13T22:41:27.797575Z","end":"2026-02-13T22:41:27.929063Z","steps":["trace[839932918] 'process raft request' (duration: 131.147668ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:28.553855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.148602ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-13T22:41:28.554168Z","caller":"traceutil/trace.go:171","msg":"trace[1395273922] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"594.227929ms","start":"2026-02-13T22:41:27.959913Z","end":"2026-02-13T22:41:28.554141Z","steps":["trace[1395273922] 'process raft request' (duration: 50.745507ms)","trace[1395273922] 'compare' (duration: 542.997048ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:41:28.554274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:27.959897Z","time spent":"594.323041ms","remote":"127.0.0.1:39154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T22:41:28.554916Z","caller":"traceutil/trace.go:171","msg":"trace[1969245643] linearizableReadLoop","detail":"{readStateIndex:502; appliedIndex:500; }","duration":"361.701884ms","start":"2026-02-13T22:41:28.193178Z","end":"2026-02-13T22:41:28.55488Z","steps":["trace[1969245643] 'read index received' (duration: 42.741µs)","trace[1969245643] 'applied index is now lower than readState.Index' (duration: 361.658263ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:41:28.555085Z","caller":"traceutil/trace.go:171","msg":"trace[159940860] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"594.442574ms","start":"2026-02-13T22:41:27.960586Z","end":"2026-02-13T22:41:28.555029Z","steps":["trace[159940860] 'process raft request' (duration: 593.351283ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:28.555129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:27.960565Z","time spent":"594.542117ms","remote":"127.0.0.1:39154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":505,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-13T22:41:28.555355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.544149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T22:41:28.555636Z","caller":"traceutil/trace.go:171","msg":"trace[1148106429] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:482; }","duration":"132.860117ms","start":"2026-02-13T22:41:28.422767Z","end":"2026-02-13T22:41:28.555627Z","steps":["trace[1148106429] 'agreement among raft nodes before linearized reading' (duration: 132.509427ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:28.555778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.59943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T22:41:28.555799Z","caller":"traceutil/trace.go:171","msg":"trace[374372879] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:482; }","duration":"362.656331ms","start":"2026-02-13T22:41:28.193136Z","end":"2026-02-13T22:41:28.555792Z","steps":["trace[374372879] 'agreement among raft nodes before linearized reading' (duration: 362.62101ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:28.55582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:28.193117Z","time spent":"362.697942ms","remote":"127.0.0.1:41750","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-13T22:41:29.272049Z","caller":"traceutil/trace.go:171","msg":"trace[482040755] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"158.062181ms","start":"2026-02-13T22:41:29.113964Z","end":"2026-02-13T22:41:29.272026Z","steps":["trace[482040755] 'process raft request' (duration: 157.904587ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:30.733241Z","caller":"traceutil/trace.go:171","msg":"trace[772303381] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"156.643865ms","start":"2026-02-13T22:41:30.576575Z","end":"2026-02-13T22:41:30.733219Z","steps":["trace[772303381] 'process raft request' (duration: 156.504761ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:30.755876Z","caller":"traceutil/trace.go:171","msg":"trace[520009250] linearizableReadLoop","detail":"{readStateIndex:539; appliedIndex:537; }","duration":"155.116722ms","start":"2026-02-13T22:41:30.600741Z","end":"2026-02-13T22:41:30.755858Z","steps":["trace[520009250] 'read index received' (duration: 132.292342ms)","trace[520009250] 'applied index is now lower than readState.Index' (duration: 22.82351ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:41:30.756004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.243326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4019"} {"level":"info","ts":"2026-02-13T22:41:30.756053Z","caller":"traceutil/trace.go:171","msg":"trace[337952480] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:519; }","duration":"155.330068ms","start":"2026-02-13T22:41:30.600712Z","end":"2026-02-13T22:41:30.756042Z","steps":["trace[337952480] 'agreement among raft nodes before linearized reading' (duration: 155.216865ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:30.756282Z","caller":"traceutil/trace.go:171","msg":"trace[955665848] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"177.296225ms","start":"2026-02-13T22:41:30.578976Z","end":"2026-02-13T22:41:30.756272Z","steps":["trace[955665848] 'process raft request' (duration: 176.814071ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:31.022632Z","caller":"traceutil/trace.go:171","msg":"trace[1720807087] linearizableReadLoop","detail":"{readStateIndex:540; appliedIndex:539; }","duration":"256.370117ms","start":"2026-02-13T22:41:30.766241Z","end":"2026-02-13T22:41:31.022611Z","steps":["trace[1720807087] 'read index received' (duration: 255.896994ms)","trace[1720807087] 'applied index is now lower than readState.Index' (duration: 472.133µs)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:41:31.023225Z","caller":"traceutil/trace.go:171","msg":"trace[374378051] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"257.880519ms","start":"2026-02-13T22:41:30.765326Z","end":"2026-02-13T22:41:31.023206Z","steps":["trace[374378051] 'process raft request' (duration: 256.877582ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:31.024541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.515231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-13T22:41:31.024608Z","caller":"traceutil/trace.go:171","msg":"trace[1633611937] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:520; }","duration":"258.370523ms","start":"2026-02-13T22:41:30.76621Z","end":"2026-02-13T22:41:31.02458Z","steps":["trace[1633611937] 'agreement among raft nodes before linearized reading' (duration: 256.48756ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:31.306583Z","caller":"traceutil/trace.go:171","msg":"trace[739466695] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"267.423266ms","start":"2026-02-13T22:41:31.03913Z","end":"2026-02-13T22:41:31.306553Z","steps":["trace[739466695] 'process raft request' (duration: 266.966433ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:31.829872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.949389ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T22:41:31.829944Z","caller":"traceutil/trace.go:171","msg":"trace[455219891] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"174.322861ms","start":"2026-02-13T22:41:31.65561Z","end":"2026-02-13T22:41:31.829933Z","steps":["trace[455219891] 'process raft request' (duration: 62.251968ms)","trace[455219891] 'compare' (duration: 111.743424ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:41:33.563166Z","caller":"traceutil/trace.go:171","msg":"trace[546931398] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"167.25475ms","start":"2026-02-13T22:41:33.39589Z","end":"2026-02-13T22:41:33.563145Z","steps":["trace[546931398] 'process raft request' (duration: 99.318882ms)","trace[546931398] 'compare' (duration: 67.835655ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:41:36.600534Z","caller":"traceutil/trace.go:171","msg":"trace[1758162984] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"114.678886ms","start":"2026-02-13T22:41:36.485836Z","end":"2026-02-13T22:41:36.600515Z","steps":["trace[1758162984] 'process raft request' (duration: 114.510191ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:36.744236Z","caller":"traceutil/trace.go:171","msg":"trace[561836465] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"235.382911ms","start":"2026-02-13T22:41:36.50883Z","end":"2026-02-13T22:41:36.744213Z","steps":["trace[561836465] 'process raft request' (duration: 223.718434ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:36.746815Z","caller":"traceutil/trace.go:171","msg":"trace[469558421] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"237.890658ms","start":"2026-02-13T22:41:36.508909Z","end":"2026-02-13T22:41:36.7468Z","steps":["trace[469558421] 'process raft request' (duration: 230.302167ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:36.74705Z","caller":"traceutil/trace.go:171","msg":"trace[1323176717] linearizableReadLoop","detail":"{readStateIndex:590; appliedIndex:587; }","duration":"237.6156ms","start":"2026-02-13T22:41:36.508942Z","end":"2026-02-13T22:41:36.746558Z","steps":["trace[1323176717] 'read index received' (duration: 91.458733ms)","trace[1323176717] 'applied index is now lower than readState.Index' (duration: 146.155797ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:41:36.747184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.230416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-4nnnc\" ","response":"range_response_count:1 size:4639"} {"level":"info","ts":"2026-02-13T22:41:36.750824Z","caller":"traceutil/trace.go:171","msg":"trace[1866943868] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-4nnnc; range_end:; response_count:1; response_revision:569; }","duration":"241.887082ms","start":"2026-02-13T22:41:36.508929Z","end":"2026-02-13T22:41:36.750816Z","steps":["trace[1866943868] 'agreement among raft nodes before linearized reading' (duration: 238.178995ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:36.747306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.830312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T22:41:36.751087Z","caller":"traceutil/trace.go:171","msg":"trace[14313648] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:569; }","duration":"220.645522ms","start":"2026-02-13T22:41:36.530434Z","end":"2026-02-13T22:41:36.751079Z","steps":["trace[14313648] 'agreement among raft nodes before linearized reading' (duration: 216.858392ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:37.143837Z","caller":"traceutil/trace.go:171","msg":"trace[1926082667] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"207.828996ms","start":"2026-02-13T22:41:36.935988Z","end":"2026-02-13T22:41:37.143817Z","steps":["trace[1926082667] 'process raft request' (duration: 207.719633ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:37.340503Z","caller":"traceutil/trace.go:171","msg":"trace[519647122] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"201.444753ms","start":"2026-02-13T22:41:37.139023Z","end":"2026-02-13T22:41:37.340468Z","steps":["trace[519647122] 'process raft request' (duration: 199.161893ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:37.340881Z","caller":"traceutil/trace.go:171","msg":"trace[682235742] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"351.927407ms","start":"2026-02-13T22:41:36.988941Z","end":"2026-02-13T22:41:37.340868Z","steps":["trace[682235742] 'process raft request' (duration: 317.043686ms)","trace[682235742] 'compare' (duration: 32.057758ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:41:37.341133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:36.988927Z","time spent":"352.04478ms","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T22:41:37.344755Z","caller":"traceutil/trace.go:171","msg":"trace[406897618] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"181.753898ms","start":"2026-02-13T22:41:37.162992Z","end":"2026-02-13T22:41:37.344746Z","steps":["trace[406897618] 'process raft request' (duration: 175.261369ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:39.535977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:38.317977Z","time spent":"1.217995306s","remote":"127.0.0.1:56902","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-13T22:41:39.537404Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.402884048s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-13T22:41:39.539668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.603347849s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-13T22:41:39.539841Z","caller":"traceutil/trace.go:171","msg":"trace[434264174] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"1.405379341s","start":"2026-02-13T22:41:38.134451Z","end":"2026-02-13T22:41:39.53983Z","steps":["trace[434264174] 'process raft request' (duration: 1.405283659s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:39.539897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:38.134433Z","time spent":"1.405432443s","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T22:41:39.540029Z","caller":"traceutil/trace.go:171","msg":"trace[1552165858] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"1.608888433s","start":"2026-02-13T22:41:37.931135Z","end":"2026-02-13T22:41:39.540024Z","steps":["trace[1552165858] 'read index received' (duration: 5.142974ms)","trace[1552165858] 'applied index is now lower than readState.Index' (duration: 1.603744839s)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:41:39.540144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.609004276s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T22:41:39.540164Z","caller":"traceutil/trace.go:171","msg":"trace[1106705110] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:593; }","duration":"1.609052338s","start":"2026-02-13T22:41:37.931107Z","end":"2026-02-13T22:41:39.540159Z","steps":["trace[1106705110] 'agreement among raft nodes before linearized reading' (duration: 1.609008756s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:39.540178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:37.931092Z","time spent":"1.609083198s","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"info","ts":"2026-02-13T22:41:39.549545Z","caller":"traceutil/trace.go:171","msg":"trace[1752383961] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"392.450299ms","start":"2026-02-13T22:41:39.15708Z","end":"2026-02-13T22:41:39.549531Z","steps":["trace[1752383961] 'process raft request' (duration: 392.357707ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:39.549701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:39.157064Z","time spent":"392.565632ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T22:41:39.550029Z","caller":"traceutil/trace.go:171","msg":"trace[272385251] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"1.21758112s","start":"2026-02-13T22:41:38.332441Z","end":"2026-02-13T22:41:39.550023Z","steps":["trace[272385251] 'process raft request' (duration: 1.216872932s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:39.550118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:38.332422Z","time spent":"1.217650983s","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-13T22:41:39.550706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.095942955s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-13T22:41:39.554072Z","caller":"traceutil/trace.go:171","msg":"trace[714821284] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:595; }","duration":"1.099341312s","start":"2026-02-13T22:41:38.454723Z","end":"2026-02-13T22:41:39.554064Z","steps":["trace[714821284] 'agreement among raft nodes before linearized reading' (duration: 1.095905134s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:39.554193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:38.45471Z","time spent":"1.099475486s","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-13T22:41:39.554554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.899543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-02-13T22:41:39.554597Z","caller":"traceutil/trace.go:171","msg":"trace[1921243399] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:595; }","duration":"223.964335ms","start":"2026-02-13T22:41:39.330617Z","end":"2026-02-13T22:41:39.554582Z","steps":["trace[1921243399] 'agreement among raft nodes before linearized reading' (duration: 223.831061ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:39.554818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.275696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T22:41:39.554838Z","caller":"traceutil/trace.go:171","msg":"trace[936721504] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:595; }","duration":"130.342648ms","start":"2026-02-13T22:41:39.42449Z","end":"2026-02-13T22:41:39.554832Z","steps":["trace[936721504] 'agreement among raft nodes before linearized reading' (duration: 130.317797ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:39.554929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.733299ms","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-13T22:41:39.554947Z","caller":"traceutil/trace.go:171","msg":"trace[1188325337] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:595; }","duration":"191.766951ms","start":"2026-02-13T22:41:39.363174Z","end":"2026-02-13T22:41:39.554941Z","steps":["trace[1188325337] 'agreement among raft nodes before linearized reading' (duration: 191.72411ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:39.555171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.667709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-13T22:41:39.555278Z","caller":"traceutil/trace.go:171","msg":"trace[25281723] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:595; }","duration":"565.795192ms","start":"2026-02-13T22:41:38.989474Z","end":"2026-02-13T22:41:39.555269Z","steps":["trace[25281723] 'agreement among raft nodes before linearized reading' (duration: 565.630168ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:39.556106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.154987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"warn","ts":"2026-02-13T22:41:39.556154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:38.98946Z","time spent":"566.659163ms","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-13T22:41:39.555175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.024754992s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-02-13T22:41:39.556137Z","caller":"traceutil/trace.go:171","msg":"trace[1566472217] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:595; }","duration":"625.198588ms","start":"2026-02-13T22:41:38.930928Z","end":"2026-02-13T22:41:39.556127Z","steps":["trace[1566472217] 'agreement among raft nodes before linearized reading' (duration: 624.257314ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:39.556491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:38.930899Z","time spent":"625.554628ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4203,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "} {"level":"warn","ts":"2026-02-13T22:41:39.556943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"825.970121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-02-13T22:41:39.556963Z","caller":"traceutil/trace.go:171","msg":"trace[1757188865] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:595; }","duration":"826.036563ms","start":"2026-02-13T22:41:38.730921Z","end":"2026-02-13T22:41:39.556958Z","steps":["trace[1757188865] 'agreement among raft nodes before linearized reading' (duration: 825.968611ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:39.556446Z","caller":"traceutil/trace.go:171","msg":"trace[345582452] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:595; }","duration":"1.026023825s","start":"2026-02-13T22:41:38.530413Z","end":"2026-02-13T22:41:39.556436Z","steps":["trace[345582452] 'agreement among raft nodes before linearized reading' (duration: 1.024729082s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:39.557111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:38.530367Z","time spent":"1.026735174s","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":1,"response size":5609,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" "} {"level":"warn","ts":"2026-02-13T22:41:39.557114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:38.730842Z","time spent":"826.264598ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4106,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "} {"level":"info","ts":"2026-02-13T22:41:39.913778Z","caller":"traceutil/trace.go:171","msg":"trace[677204892] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"326.208313ms","start":"2026-02-13T22:41:39.587525Z","end":"2026-02-13T22:41:39.913733Z","steps":["trace[677204892] 'process raft request' (duration: 266.994147ms)","trace[677204892] 'compare' (duration: 59.130684ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:41:39.913876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:39.587508Z","time spent":"326.317996ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5153,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T22:41:39.914374Z","caller":"traceutil/trace.go:171","msg":"trace[2119090502] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"319.638776ms","start":"2026-02-13T22:41:39.594725Z","end":"2026-02-13T22:41:39.914364Z","steps":["trace[2119090502] 'process raft request' (duration: 319.528753ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:39.91442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:39.59472Z","time spent":"319.675277ms","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T22:41:39.914597Z","caller":"traceutil/trace.go:171","msg":"trace[1791503276] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"319.927462ms","start":"2026-02-13T22:41:39.594662Z","end":"2026-02-13T22:41:39.91459Z","steps":["trace[1791503276] 'process raft request' (duration: 319.551543ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:39.914633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:39.594652Z","time spent":"319.960873ms","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T22:41:39.914929Z","caller":"traceutil/trace.go:171","msg":"trace[1450917013] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"314.827403ms","start":"2026-02-13T22:41:39.600094Z","end":"2026-02-13T22:41:39.914922Z","steps":["trace[1450917013] 'process raft request' (duration: 314.179975ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:39.914966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:39.600087Z","time spent":"314.857863ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T22:41:39.915314Z","caller":"traceutil/trace.go:171","msg":"trace[1396882074] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:618; }","duration":"270.137639ms","start":"2026-02-13T22:41:39.645168Z","end":"2026-02-13T22:41:39.915306Z","steps":["trace[1396882074] 'read index received' (duration: 209.362412ms)","trace[1396882074] 'applied index is now lower than readState.Index' (duration: 60.774657ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:41:39.915363Z","caller":"traceutil/trace.go:171","msg":"trace[1241327672] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"305.217636ms","start":"2026-02-13T22:41:39.61014Z","end":"2026-02-13T22:41:39.915358Z","steps":["trace[1241327672] 'process raft request' (duration: 304.161728ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:39.9154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:39.610123Z","time spent":"305.253267ms","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T22:41:39.91553Z","caller":"traceutil/trace.go:171","msg":"trace[1855305606] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"305.324769ms","start":"2026-02-13T22:41:39.610199Z","end":"2026-02-13T22:41:39.915524Z","steps":["trace[1855305606] 'process raft request' (duration: 304.124428ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:39.915562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:39.610195Z","time spent":"305.34942ms","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T22:41:39.915683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.513408ms","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-02-13T22:41:39.915703Z","caller":"traceutil/trace.go:171","msg":"trace[161815741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:602; }","duration":"270.561979ms","start":"2026-02-13T22:41:39.645134Z","end":"2026-02-13T22:41:39.915696Z","steps":["trace[161815741] 'agreement among raft nodes before linearized reading' (duration: 270.484947ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:39.915807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.624303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-02-13T22:41:39.915827Z","caller":"traceutil/trace.go:171","msg":"trace[143649283] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:602; }","duration":"185.670175ms","start":"2026-02-13T22:41:39.730151Z","end":"2026-02-13T22:41:39.915821Z","steps":["trace[143649283] 'agreement among raft nodes before linearized reading' (duration: 185.615933ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:40.543016Z","caller":"traceutil/trace.go:171","msg":"trace[2011804595] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"157.483913ms","start":"2026-02-13T22:41:40.385516Z","end":"2026-02-13T22:41:40.543Z","steps":["trace[2011804595] 'process raft request' (duration: 157.344419ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:40.946286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.740043ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T22:41:40.946341Z","caller":"traceutil/trace.go:171","msg":"trace[1916554543] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:628; }","duration":"415.746233ms","start":"2026-02-13T22:41:40.530586Z","end":"2026-02-13T22:41:40.946332Z","steps":["trace[1916554543] 'read index received' (duration: 12.788964ms)","trace[1916554543] 'applied index is now lower than readState.Index' (duration: 402.956659ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:41:40.94663Z","caller":"traceutil/trace.go:171","msg":"trace[1241435421] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"549.297949ms","start":"2026-02-13T22:41:40.397317Z","end":"2026-02-13T22:41:40.946615Z","steps":["trace[1241435421] 'process raft request' (duration: 256.182646ms)","trace[1241435421] 'compare' (duration: 292.538678ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:41:40.946668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:40.397304Z","time spent":"549.344631ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188237,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T22:41:40.946793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.205575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-02-13T22:41:40.946808Z","caller":"traceutil/trace.go:171","msg":"trace[303609571] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:607; }","duration":"416.258476ms","start":"2026-02-13T22:41:40.530543Z","end":"2026-02-13T22:41:40.946801Z","steps":["trace[303609571] 'agreement among raft nodes before linearized reading' (duration: 416.197535ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:40.946822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:40.530528Z","time spent":"416.290507ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":9343,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "} {"level":"warn","ts":"2026-02-13T22:41:40.947397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.147451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"} {"level":"info","ts":"2026-02-13T22:41:40.947413Z","caller":"traceutil/trace.go:171","msg":"trace[1912421722] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:608; }","duration":"216.164491ms","start":"2026-02-13T22:41:40.731244Z","end":"2026-02-13T22:41:40.947408Z","steps":["trace[1912421722] 'agreement among raft nodes before linearized reading' (duration: 216.074479ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:40.947711Z","caller":"traceutil/trace.go:171","msg":"trace[594408022] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"268.508309ms","start":"2026-02-13T22:41:40.679198Z","end":"2026-02-13T22:41:40.947706Z","steps":["trace[594408022] 'process raft request' (duration: 267.986416ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:44.126478Z","caller":"traceutil/trace.go:171","msg":"trace[991951110] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"191.941257ms","start":"2026-02-13T22:41:43.934508Z","end":"2026-02-13T22:41:44.126449Z","steps":["trace[991951110] 'process raft request' (duration: 191.689281ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:44.140115Z","caller":"traceutil/trace.go:171","msg":"trace[609715668] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:640; }","duration":"194.356494ms","start":"2026-02-13T22:41:43.94573Z","end":"2026-02-13T22:41:44.140087Z","steps":["trace[609715668] 'read index received' (duration: 180.440145ms)","trace[609715668] 'applied index is now lower than readState.Index' (duration: 13.915009ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:41:44.141313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.970434ms","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-13T22:41:44.141362Z","caller":"traceutil/trace.go:171","msg":"trace[909764095] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:619; }","duration":"194.047705ms","start":"2026-02-13T22:41:43.947301Z","end":"2026-02-13T22:41:44.141349Z","steps":["trace[909764095] 'agreement among raft nodes before linearized reading' (duration: 193.874081ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:44.141491Z","caller":"traceutil/trace.go:171","msg":"trace[894944918] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"206.670135ms","start":"2026-02-13T22:41:43.934807Z","end":"2026-02-13T22:41:44.141477Z","steps":["trace[894944918] 'process raft request' (duration: 205.102418ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:44.141622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.890011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-02-13T22:41:44.142403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.102319ms","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-02-13T22:41:44.142441Z","caller":"traceutil/trace.go:171","msg":"trace[409908466] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:619; }","duration":"162.450467ms","start":"2026-02-13T22:41:43.97998Z","end":"2026-02-13T22:41:44.142431Z","steps":["trace[409908466] 'agreement among raft nodes before linearized reading' (duration: 162.086828ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:44.141654Z","caller":"traceutil/trace.go:171","msg":"trace[2027330232] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:619; }","duration":"195.919961ms","start":"2026-02-13T22:41:43.945723Z","end":"2026-02-13T22:41:44.141643Z","steps":["trace[2027330232] 'agreement among raft nodes before linearized reading' (duration: 195.832499ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:49.923898Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430388353291746679,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T22:41:49.956199Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.409557052s","expected-duration":"1s"} {"level":"info","ts":"2026-02-13T22:41:49.956554Z","caller":"traceutil/trace.go:171","msg":"trace[399179239] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:660; }","duration":"533.623573ms","start":"2026-02-13T22:41:49.42291Z","end":"2026-02-13T22:41:49.956533Z","steps":["trace[399179239] 'read index received' (duration: 533.389268ms)","trace[399179239] 'applied index is now lower than readState.Index' (duration: 233.675µs)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:41:49.956661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.731606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T22:41:49.956702Z","caller":"traceutil/trace.go:171","msg":"trace[1551466749] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"533.801838ms","start":"2026-02-13T22:41:49.422879Z","end":"2026-02-13T22:41:49.956681Z","steps":["trace[1551466749] 'agreement among raft nodes before linearized reading' (duration: 533.715086ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:49.956736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:49.422862Z","time spent":"533.865659ms","remote":"127.0.0.1:41750","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-13T22:41:49.957031Z","caller":"traceutil/trace.go:171","msg":"trace[2066173074] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"1.410460163s","start":"2026-02-13T22:41:48.546559Z","end":"2026-02-13T22:41:49.957019Z","steps":["trace[2066173074] 'process raft request' (duration: 1.409825328s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:49.957113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:48.546545Z","time spent":"1.410513884s","remote":"127.0.0.1:39146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T22:41:52.102965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.95465657s","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-13T22:41:52.103063Z","caller":"traceutil/trace.go:171","msg":"trace[1592222423] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:637; }","duration":"1.954794143s","start":"2026-02-13T22:41:50.148241Z","end":"2026-02-13T22:41:52.103036Z","steps":["trace[1592222423] 'range keys from in-memory index tree' (duration: 1.954491956s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:52.103121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:50.148225Z","time spent":"1.954888756s","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-13T22:41:52.103351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.934123997s","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-02-13T22:41:52.103367Z","caller":"traceutil/trace.go:171","msg":"trace[1665102735] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:637; }","duration":"1.934161437s","start":"2026-02-13T22:41:50.1692Z","end":"2026-02-13T22:41:52.103362Z","steps":["trace[1665102735] 'range keys from in-memory index tree' (duration: 1.934034395s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:52.103393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:50.169185Z","time spent":"1.934192448s","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-13T22:41:52.10342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.664894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.140\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-13T22:41:52.103498Z","caller":"traceutil/trace.go:171","msg":"trace[1973734415] range","detail":"{range_begin:/registry/masterleases/162.253.55.140; range_end:; response_count:1; response_revision:637; }","duration":"493.777626ms","start":"2026-02-13T22:41:51.609699Z","end":"2026-02-13T22:41:52.103477Z","steps":["trace[1973734415] 'range keys from in-memory index tree' (duration: 493.48063ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:52.103515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.917290078s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-13T22:41:52.103536Z","caller":"traceutil/trace.go:171","msg":"trace[1343351898] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:637; }","duration":"1.91733028s","start":"2026-02-13T22:41:50.1862Z","end":"2026-02-13T22:41:52.103531Z","steps":["trace[1343351898] 'range keys from in-memory index tree' (duration: 1.917217737s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:52.103542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:51.609683Z","time spent":"493.850348ms","remote":"127.0.0.1:38986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.140\" "} {"level":"warn","ts":"2026-02-13T22:41:52.103606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.909915199s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-13T22:41:52.103635Z","caller":"traceutil/trace.go:171","msg":"trace[1768908891] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:637; }","duration":"1.90995232s","start":"2026-02-13T22:41:50.193679Z","end":"2026-02-13T22:41:52.103631Z","steps":["trace[1768908891] 'range keys from in-memory index tree' (duration: 1.909848267s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:52.103648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:50.193669Z","time spent":"1.90997488s","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-13T22:41:52.103762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.906170924s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-13T22:41:52.103776Z","caller":"traceutil/trace.go:171","msg":"trace[1295540545] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:637; }","duration":"1.906194104s","start":"2026-02-13T22:41:50.197577Z","end":"2026-02-13T22:41:52.103772Z","steps":["trace[1295540545] 'range keys from in-memory index tree' (duration: 1.906130012s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:52.103803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:50.197571Z","time spent":"1.906227315s","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-13T22:41:52.103565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:50.186188Z","time spent":"1.91737299s","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-13T22:41:52.10397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.679813996s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T22:41:52.103988Z","caller":"traceutil/trace.go:171","msg":"trace[1906553729] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"1.679858817s","start":"2026-02-13T22:41:50.424124Z","end":"2026-02-13T22:41:52.103983Z","steps":["trace[1906553729] 'range keys from in-memory index tree' (duration: 1.679756944s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:52.104003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:50.424108Z","time spent":"1.679891557s","remote":"127.0.0.1:41750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-13T22:41:52.611068Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430388353291746689,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T22:41:52.868337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:52.110051Z","time spent":"758.280859ms","remote":"127.0.0.1:38986","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-13T22:41:53.749861Z","caller":"traceutil/trace.go:171","msg":"trace[1334507455] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:662; }","duration":"1.639354006s","start":"2026-02-13T22:41:52.110493Z","end":"2026-02-13T22:41:53.749847Z","steps":["trace[1334507455] 'read index received' (duration: 757.964273ms)","trace[1334507455] 'applied index is now lower than readState.Index' (duration: 881.389123ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:41:53.749948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.639442908s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T22:41:53.749964Z","caller":"traceutil/trace.go:171","msg":"trace[802531986] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"1.639489598s","start":"2026-02-13T22:41:52.110469Z","end":"2026-02-13T22:41:53.749959Z","steps":["trace[802531986] 'agreement among raft nodes before linearized reading' (duration: 1.639434507s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:53.749981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:52.110451Z","time spent":"1.6395261s","remote":"127.0.0.1:41752","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-13T22:41:53.75013Z","caller":"traceutil/trace.go:171","msg":"trace[708647497] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"1.637828771s","start":"2026-02-13T22:41:52.112295Z","end":"2026-02-13T22:41:53.750124Z","steps":["trace[708647497] 'process raft request' (duration: 1.615328566s)","trace[708647497] 'compare' (duration: 22.031305ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:41:53.750179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:52.11228Z","time spent":"1.637862951s","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T22:41:53.750234Z","caller":"traceutil/trace.go:171","msg":"trace[1020885345] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"1.635806165s","start":"2026-02-13T22:41:52.114423Z","end":"2026-02-13T22:41:53.750229Z","steps":["trace[1020885345] 'process raft request' (duration: 1.635312534s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:53.750255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:52.114408Z","time spent":"1.635834527s","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T22:41:53.750306Z","caller":"traceutil/trace.go:171","msg":"trace[68419365] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"1.63335537s","start":"2026-02-13T22:41:52.116947Z","end":"2026-02-13T22:41:53.750303Z","steps":["trace[68419365] 'process raft request' (duration: 1.632834598s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:53.754445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:52.116916Z","time spent":"1.637498814s","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T22:41:53.75054Z","caller":"traceutil/trace.go:171","msg":"trace[763836609] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"1.633477932s","start":"2026-02-13T22:41:52.117031Z","end":"2026-02-13T22:41:53.750509Z","steps":["trace[763836609] 'process raft request' (duration: 1.632771147s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:53.755202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:52.117026Z","time spent":"1.638151397s","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T22:41:53.750606Z","caller":"traceutil/trace.go:171","msg":"trace[1921508982] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"1.633525183s","start":"2026-02-13T22:41:52.117067Z","end":"2026-02-13T22:41:53.750592Z","steps":["trace[1921508982] 'process raft request' (duration: 1.632761806s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:53.759209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:52.117062Z","time spent":"1.642106097s","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T22:41:53.804306Z","caller":"traceutil/trace.go:171","msg":"trace[1961145741] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"695.324294ms","start":"2026-02-13T22:41:53.108963Z","end":"2026-02-13T22:41:53.804287Z","steps":["trace[1961145741] 'process raft request' (duration: 695.063108ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:53.804399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:53.108924Z","time spent":"695.425806ms","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T22:41:53.804307Z","caller":"traceutil/trace.go:171","msg":"trace[582953340] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"935.034526ms","start":"2026-02-13T22:41:52.86925Z","end":"2026-02-13T22:41:53.804285Z","steps":["trace[582953340] 'process raft request' (duration: 934.680577ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:53.804513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:52.86923Z","time spent":"935.226161ms","remote":"127.0.0.1:38986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T22:41:54.673431Z","caller":"traceutil/trace.go:171","msg":"trace[578345029] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"102.216932ms","start":"2026-02-13T22:41:54.571195Z","end":"2026-02-13T22:41:54.673412Z","steps":["trace[578345029] 'process raft request' (duration: 102.107009ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:55.900935Z","caller":"traceutil/trace.go:171","msg":"trace[1853796759] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"117.13873ms","start":"2026-02-13T22:41:55.783781Z","end":"2026-02-13T22:41:55.90092Z","steps":["trace[1853796759] 'process raft request' (duration: 70.049043ms)","trace[1853796759] 'compare' (duration: 46.802431ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:41:55.901015Z","caller":"traceutil/trace.go:171","msg":"trace[423905487] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"114.294807ms","start":"2026-02-13T22:41:55.786716Z","end":"2026-02-13T22:41:55.901011Z","steps":["trace[423905487] 'process raft request' (duration: 113.990891ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:56.880871Z","caller":"traceutil/trace.go:171","msg":"trace[570208115] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"287.304312ms","start":"2026-02-13T22:41:56.593548Z","end":"2026-02-13T22:41:56.880852Z","steps":["trace[570208115] 'process raft request' (duration: 287.20225ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:57.707814Z","caller":"traceutil/trace.go:171","msg":"trace[1806048272] linearizableReadLoop","detail":"{readStateIndex:688; appliedIndex:687; }","duration":"137.293741ms","start":"2026-02-13T22:41:57.570505Z","end":"2026-02-13T22:41:57.707799Z","steps":["trace[1806048272] 'read index received' (duration: 137.165178ms)","trace[1806048272] 'applied index is now lower than readState.Index' (duration: 128.053µs)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:41:57.707843Z","caller":"traceutil/trace.go:171","msg":"trace[1478467308] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"204.714719ms","start":"2026-02-13T22:41:57.503102Z","end":"2026-02-13T22:41:57.707816Z","steps":["trace[1478467308] 'process raft request' (duration: 204.610157ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:57.707965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.444624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-blzcp\" ","response":"range_response_count:1 size:17415"} {"level":"info","ts":"2026-02-13T22:41:57.70799Z","caller":"traceutil/trace.go:171","msg":"trace[1675235783] range","detail":"{range_begin:/registry/pods/kube-system/cilium-blzcp; range_end:; response_count:1; response_revision:662; }","duration":"137.520725ms","start":"2026-02-13T22:41:57.570464Z","end":"2026-02-13T22:41:57.707985Z","steps":["trace[1675235783] 'agreement among raft nodes before linearized reading' (duration: 137.394673ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:58.098907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.061841ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T22:41:58.099015Z","caller":"traceutil/trace.go:171","msg":"trace[1484191622] linearizableReadLoop","detail":"{readStateIndex:689; appliedIndex:688; }","duration":"331.491765ms","start":"2026-02-13T22:41:57.767508Z","end":"2026-02-13T22:41:58.099Z","steps":["trace[1484191622] 'read index received' (duration: 113.235451ms)","trace[1484191622] 'applied index is now lower than readState.Index' (duration: 218.255094ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:41:58.099228Z","caller":"traceutil/trace.go:171","msg":"trace[1884607995] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"382.191712ms","start":"2026-02-13T22:41:57.717025Z","end":"2026-02-13T22:41:58.099216Z","steps":["trace[1884607995] 'process raft request' (duration: 163.740793ms)","trace[1884607995] 'compare' (duration: 217.678742ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:41:58.099297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:57.717003Z","time spent":"382.260184ms","remote":"127.0.0.1:39146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17562,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T22:41:58.099532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.029016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-13T22:41:58.099567Z","caller":"traceutil/trace.go:171","msg":"trace[987803423] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:663; }","duration":"332.085988ms","start":"2026-02-13T22:41:57.767471Z","end":"2026-02-13T22:41:58.099557Z","steps":["trace[987803423] 'agreement among raft nodes before linearized reading' (duration: 331.975126ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:58.099601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:57.767451Z","time spent":"332.143359ms","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-13T22:41:58.099779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.670763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-13T22:41:58.09981Z","caller":"traceutil/trace.go:171","msg":"trace[305668722] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:663; }","duration":"328.702033ms","start":"2026-02-13T22:41:57.771101Z","end":"2026-02-13T22:41:58.099803Z","steps":["trace[305668722] 'agreement among raft nodes before linearized reading' (duration: 328.624112ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:58.09984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:57.771047Z","time spent":"328.787396ms","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-13T22:41:58.100136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.228984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-13T22:41:58.100171Z","caller":"traceutil/trace.go:171","msg":"trace[687334532] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:663; }","duration":"194.277285ms","start":"2026-02-13T22:41:57.905886Z","end":"2026-02-13T22:41:58.100163Z","steps":["trace[687334532] 'agreement among raft nodes before linearized reading' (duration: 194.195723ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:58.100318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.633205ms","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-13T22:41:58.100343Z","caller":"traceutil/trace.go:171","msg":"trace[1372695476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:663; }","duration":"195.690867ms","start":"2026-02-13T22:41:57.904645Z","end":"2026-02-13T22:41:58.100336Z","steps":["trace[1372695476] 'agreement among raft nodes before linearized reading' (duration: 195.618065ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:58.10048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.699431ms","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-02-13T22:41:58.100505Z","caller":"traceutil/trace.go:171","msg":"trace[421115082] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:663; }","duration":"308.745602ms","start":"2026-02-13T22:41:57.791751Z","end":"2026-02-13T22:41:58.100497Z","steps":["trace[421115082] 'agreement among raft nodes before linearized reading' (duration: 308.680581ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:58.100529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:57.791741Z","time spent":"308.781883ms","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-13T22:41:58.217858Z","caller":"traceutil/trace.go:171","msg":"trace[893629690] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"107.680009ms","start":"2026-02-13T22:41:58.110148Z","end":"2026-02-13T22:41:58.217828Z","steps":["trace[893629690] 'process raft request' (duration: 107.241659ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:58.218082Z","caller":"traceutil/trace.go:171","msg":"trace[1669691720] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"107.881824ms","start":"2026-02-13T22:41:58.110176Z","end":"2026-02-13T22:41:58.218058Z","steps":["trace[1669691720] 'process raft request' (duration: 107.537666ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:58.218421Z","caller":"traceutil/trace.go:171","msg":"trace[569535977] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"105.919562ms","start":"2026-02-13T22:41:58.112487Z","end":"2026-02-13T22:41:58.218407Z","steps":["trace[569535977] 'process raft request' (duration: 105.863541ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:58.218495Z","caller":"traceutil/trace.go:171","msg":"trace[1315570738] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"107.446065ms","start":"2026-02-13T22:41:58.11104Z","end":"2026-02-13T22:41:58.218486Z","steps":["trace[1315570738] 'process raft request' (duration: 106.945294ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:59.86333Z","caller":"traceutil/trace.go:171","msg":"trace[1630928131] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"258.074996ms","start":"2026-02-13T22:41:59.605238Z","end":"2026-02-13T22:41:59.863313Z","steps":["trace[1630928131] 'process raft request' (duration: 257.876692ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:41:59.913394Z","caller":"traceutil/trace.go:171","msg":"trace[1140896819] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"307.833205ms","start":"2026-02-13T22:41:59.605542Z","end":"2026-02-13T22:41:59.913375Z","steps":["trace[1140896819] 'process raft request' (duration: 296.78892ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:41:59.913497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:41:59.605534Z","time spent":"307.911496ms","remote":"127.0.0.1:39040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":751,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-13T22:42:01.65368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.440989627s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-13T22:42:01.655296Z","caller":"traceutil/trace.go:171","msg":"trace[1788054804] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"1.484885181s","start":"2026-02-13T22:42:00.170387Z","end":"2026-02-13T22:42:01.655272Z","steps":["trace[1788054804] 'process raft request' (duration: 42.24713ms)","trace[1788054804] 'compare' (duration: 1.440726421s)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:42:01.655401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:42:00.170366Z","time spent":"1.484980462s","remote":"127.0.0.1:39040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-13T22:42:01.655735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.459275701s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-13T22:42:01.655766Z","caller":"traceutil/trace.go:171","msg":"trace[53574272] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:676; }","duration":"1.459340532s","start":"2026-02-13T22:42:00.196419Z","end":"2026-02-13T22:42:01.65576Z","steps":["trace[53574272] 'agreement among raft nodes before linearized reading' (duration: 1.459216029s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:42:01.655784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:42:00.196404Z","time spent":"1.459376753s","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-13T22:42:01.660236Z","caller":"traceutil/trace.go:171","msg":"trace[1380161041] linearizableReadLoop","detail":"{readStateIndex:702; appliedIndex:701; }","duration":"1.458821402s","start":"2026-02-13T22:42:00.19645Z","end":"2026-02-13T22:42:01.655271Z","steps":["trace[1380161041] 'read index received' (duration: 16.152341ms)","trace[1380161041] 'applied index is now lower than readState.Index' (duration: 1.442667331s)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:42:01.660635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.06219225s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-blzcp\" ","response":"range_response_count:1 size:17918"} {"level":"info","ts":"2026-02-13T22:42:01.66066Z","caller":"traceutil/trace.go:171","msg":"trace[610211140] range","detail":"{range_begin:/registry/pods/kube-system/cilium-blzcp; range_end:; response_count:1; response_revision:676; }","duration":"1.062239621s","start":"2026-02-13T22:42:00.598415Z","end":"2026-02-13T22:42:01.660654Z","steps":["trace[610211140] 'agreement among raft nodes before linearized reading' (duration: 1.06217117s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:42:01.660676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:42:00.598401Z","time spent":"1.062272552s","remote":"127.0.0.1:39146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17941,"request content":"key:\"/registry/pods/kube-system/cilium-blzcp\" "} {"level":"warn","ts":"2026-02-13T22:42:01.660952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.6023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-13T22:42:01.660973Z","caller":"traceutil/trace.go:171","msg":"trace[939411807] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:676; }","duration":"633.644621ms","start":"2026-02-13T22:42:01.027323Z","end":"2026-02-13T22:42:01.660968Z","steps":["trace[939411807] 'agreement among raft nodes before linearized reading' (duration: 633.60976ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:42:01.660987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:42:01.027305Z","time spent":"633.678032ms","remote":"127.0.0.1:39388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-02-13T22:42:01.661231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.437860368s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-13T22:42:01.662634Z","caller":"traceutil/trace.go:171","msg":"trace[220293747] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:676; }","duration":"1.439670187s","start":"2026-02-13T22:42:00.222954Z","end":"2026-02-13T22:42:01.662624Z","steps":["trace[220293747] 'agreement among raft nodes before linearized reading' (duration: 1.437593043s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:42:01.661251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.436042089s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-13T22:42:01.661272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.237541046s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-13T22:42:01.661308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.436716245s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-13T22:42:01.661344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.436773565s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-02-13T22:42:01.662759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:42:00.222938Z","time spent":"1.439813289s","remote":"127.0.0.1:39232","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-13T22:42:01.662808Z","caller":"traceutil/trace.go:171","msg":"trace[1662001957] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:676; }","duration":"1.437607692s","start":"2026-02-13T22:42:00.225194Z","end":"2026-02-13T22:42:01.662801Z","steps":["trace[1662001957] 'agreement among raft nodes before linearized reading' (duration: 1.436023019s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:42:01.663065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:42:00.225188Z","time spent":"1.437871569s","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-13T22:42:01.662843Z","caller":"traceutil/trace.go:171","msg":"trace[821672749] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:676; }","duration":"1.239136689s","start":"2026-02-13T22:42:00.423702Z","end":"2026-02-13T22:42:01.662838Z","steps":["trace[821672749] 'agreement among raft nodes before linearized reading' (duration: 1.237560776s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:42:01.663111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:42:00.423684Z","time spent":"1.239424466s","remote":"127.0.0.1:41750","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-13T22:42:01.662905Z","caller":"traceutil/trace.go:171","msg":"trace[1980449002] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:676; }","duration":"1.438317878s","start":"2026-02-13T22:42:00.22458Z","end":"2026-02-13T22:42:01.662898Z","steps":["trace[1980449002] 'agreement among raft nodes before linearized reading' (duration: 1.436705254s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:42:01.663192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:42:00.224577Z","time spent":"1.438611334s","remote":"127.0.0.1:39232","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-02-13T22:42:01.662939Z","caller":"traceutil/trace.go:171","msg":"trace[87779792] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:676; }","duration":"1.43838045s","start":"2026-02-13T22:42:00.224554Z","end":"2026-02-13T22:42:01.662934Z","steps":["trace[87779792] 'agreement among raft nodes before linearized reading' (duration: 1.436765996s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:42:01.663251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:42:00.224547Z","time spent":"1.438700957s","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-13T22:42:05.251418Z","caller":"traceutil/trace.go:171","msg":"trace[1181021672] linearizableReadLoop","detail":"{readStateIndex:729; appliedIndex:728; }","duration":"150.9868ms","start":"2026-02-13T22:42:05.100393Z","end":"2026-02-13T22:42:05.25138Z","steps":["trace[1181021672] 'read index received' (duration: 120.588606ms)","trace[1181021672] 'applied index is now lower than readState.Index' (duration: 30.396034ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:42:05.251404Z","caller":"traceutil/trace.go:171","msg":"trace[2105197972] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"150.731375ms","start":"2026-02-13T22:42:05.100639Z","end":"2026-02-13T22:42:05.25137Z","steps":["trace[2105197972] 'process raft request' (duration: 150.608773ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:05.251693Z","caller":"traceutil/trace.go:171","msg":"trace[1526581024] transaction","detail":"{read_only:false; number_of_response:0; response_revision:700; }","duration":"216.727398ms","start":"2026-02-13T22:42:05.034953Z","end":"2026-02-13T22:42:05.25168Z","steps":["trace[1526581024] 'process raft request' (duration: 186.012738ms)","trace[1526581024] 'compare' (duration: 30.178179ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:42:05.251829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.414568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:1 size:1889"} {"level":"info","ts":"2026-02-13T22:42:05.251853Z","caller":"traceutil/trace.go:171","msg":"trace[3050987] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:1; response_revision:701; }","duration":"151.50311ms","start":"2026-02-13T22:42:05.100343Z","end":"2026-02-13T22:42:05.251846Z","steps":["trace[3050987] 'agreement among raft nodes before linearized reading' (duration: 151.404608ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:05.535735Z","caller":"traceutil/trace.go:171","msg":"trace[790536160] linearizableReadLoop","detail":"{readStateIndex:731; appliedIndex:730; }","duration":"111.364249ms","start":"2026-02-13T22:42:05.424339Z","end":"2026-02-13T22:42:05.535704Z","steps":["trace[790536160] 'read index received' (duration: 48.601351ms)","trace[790536160] 'applied index is now lower than readState.Index' (duration: 62.761758ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:42:05.53591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.541672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T22:42:05.535942Z","caller":"traceutil/trace.go:171","msg":"trace[997389748] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:702; }","duration":"111.650164ms","start":"2026-02-13T22:42:05.424283Z","end":"2026-02-13T22:42:05.535934Z","steps":["trace[997389748] 'agreement among raft nodes before linearized reading' (duration: 111.528302ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:05.536024Z","caller":"traceutil/trace.go:171","msg":"trace[1705783889] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"272.23454ms","start":"2026-02-13T22:42:05.263766Z","end":"2026-02-13T22:42:05.536Z","steps":["trace[1705783889] 'process raft request' (duration: 209.266958ms)","trace[1705783889] 'compare' (duration: 62.485002ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:42:06.09358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.594449ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T22:42:06.093707Z","caller":"traceutil/trace.go:171","msg":"trace[202273639] linearizableReadLoop","detail":"{readStateIndex:734; appliedIndex:732; }","duration":"278.196197ms","start":"2026-02-13T22:42:05.815489Z","end":"2026-02-13T22:42:06.093685Z","steps":["trace[202273639] 'read index received' (duration: 73.456104ms)","trace[202273639] 'applied index is now lower than readState.Index' (duration: 204.739403ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:42:06.093897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.335395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:1 size:2252"} {"level":"info","ts":"2026-02-13T22:42:06.093914Z","caller":"traceutil/trace.go:171","msg":"trace[1791404620] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:1; response_revision:705; }","duration":"310.363036ms","start":"2026-02-13T22:42:05.783546Z","end":"2026-02-13T22:42:06.093909Z","steps":["trace[1791404620] 'agreement among raft nodes before linearized reading' (duration: 310.178892ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:42:06.093945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:42:05.783538Z","time spent":"310.390936ms","remote":"127.0.0.1:56872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":2275,"request content":"key:\"/registry/cilium.io/ciliumnodes/instance\" "} {"level":"info","ts":"2026-02-13T22:42:06.09398Z","caller":"traceutil/trace.go:171","msg":"trace[2018010230] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"316.97301ms","start":"2026-02-13T22:42:05.776971Z","end":"2026-02-13T22:42:06.093944Z","steps":["trace[2018010230] 'process raft request' (duration: 111.943061ms)","trace[2018010230] 'compare' (duration: 204.490187ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:42:06.09408Z","caller":"traceutil/trace.go:171","msg":"trace[1117484534] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"316.145112ms","start":"2026-02-13T22:42:05.777928Z","end":"2026-02-13T22:42:06.094073Z","steps":["trace[1117484534] 'process raft request' (duration: 315.725564ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:42:06.094133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:42:05.777898Z","time spent":"316.217604ms","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T22:42:06.094166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:42:05.776965Z","time spent":"317.085012ms","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T22:42:06.094258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.57558ms","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-13T22:42:06.094274Z","caller":"traceutil/trace.go:171","msg":"trace[607347238] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:705; }","duration":"310.5914ms","start":"2026-02-13T22:42:05.783677Z","end":"2026-02-13T22:42:06.094268Z","steps":["trace[607347238] 'agreement among raft nodes before linearized reading' (duration: 310.535919ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:42:06.094286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:42:05.78365Z","time spent":"310.633181ms","remote":"127.0.0.1:39232","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-02-13T22:42:06.098702Z","caller":"traceutil/trace.go:171","msg":"trace[1674325319] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"278.41314ms","start":"2026-02-13T22:42:05.820282Z","end":"2026-02-13T22:42:06.098695Z","steps":["trace[1674325319] 'process raft request' (duration: 278.376019ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:06.245367Z","caller":"traceutil/trace.go:171","msg":"trace[940567290] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"134.27251ms","start":"2026-02-13T22:42:06.111066Z","end":"2026-02-13T22:42:06.245339Z","steps":["trace[940567290] 'process raft request' (duration: 84.3678ms)","trace[940567290] 'compare' (duration: 49.388969ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:42:12.244826Z","caller":"traceutil/trace.go:171","msg":"trace[487402029] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"117.662036ms","start":"2026-02-13T22:42:12.127149Z","end":"2026-02-13T22:42:12.244811Z","steps":["trace[487402029] 'process raft request' (duration: 114.930703ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:12.295048Z","caller":"traceutil/trace.go:171","msg":"trace[418735459] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"164.950749ms","start":"2026-02-13T22:42:12.130082Z","end":"2026-02-13T22:42:12.295032Z","steps":["trace[418735459] 'process raft request' (duration: 164.837317ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:12.295182Z","caller":"traceutil/trace.go:171","msg":"trace[425275335] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"162.337699ms","start":"2026-02-13T22:42:12.132838Z","end":"2026-02-13T22:42:12.295175Z","steps":["trace[425275335] 'process raft request' (duration: 162.164205ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:12.295386Z","caller":"traceutil/trace.go:171","msg":"trace[634244297] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:804; }","duration":"153.301845ms","start":"2026-02-13T22:42:12.142079Z","end":"2026-02-13T22:42:12.29538Z","steps":["trace[634244297] 'read index received' (duration: 99.902197ms)","trace[634244297] 'applied index is now lower than readState.Index' (duration: 53.398978ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:42:12.295452Z","caller":"traceutil/trace.go:171","msg":"trace[1444093545] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"162.571123ms","start":"2026-02-13T22:42:12.132877Z","end":"2026-02-13T22:42:12.295448Z","steps":["trace[1444093545] 'process raft request' (duration: 162.275257ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:12.295596Z","caller":"traceutil/trace.go:171","msg":"trace[1905402308] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"162.685405ms","start":"2026-02-13T22:42:12.132905Z","end":"2026-02-13T22:42:12.295591Z","steps":["trace[1905402308] 'process raft request' (duration: 162.427171ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:12.295783Z","caller":"traceutil/trace.go:171","msg":"trace[1659923942] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"162.608584ms","start":"2026-02-13T22:42:12.13316Z","end":"2026-02-13T22:42:12.295769Z","steps":["trace[1659923942] 'process raft request' (duration: 162.194346ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:42:12.295903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.808916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-13T22:42:12.295925Z","caller":"traceutil/trace.go:171","msg":"trace[1621948421] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:779; }","duration":"153.864867ms","start":"2026-02-13T22:42:12.142053Z","end":"2026-02-13T22:42:12.295918Z","steps":["trace[1621948421] 'agreement among raft nodes before linearized reading' (duration: 153.819386ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:18.616267Z","caller":"traceutil/trace.go:171","msg":"trace[2130290434] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"109.413574ms","start":"2026-02-13T22:42:18.506823Z","end":"2026-02-13T22:42:18.616236Z","steps":["trace[2130290434] 'process raft request' (duration: 99.417312ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:19.290566Z","caller":"traceutil/trace.go:171","msg":"trace[1824749283] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"340.688089ms","start":"2026-02-13T22:42:18.94986Z","end":"2026-02-13T22:42:19.290549Z","steps":["trace[1824749283] 'process raft request' (duration: 340.607107ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:42:19.290651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:42:18.949842Z","time spent":"340.770041ms","remote":"127.0.0.1:39040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":815,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T22:42:20.238628Z","caller":"traceutil/trace.go:171","msg":"trace[521168458] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"144.20133ms","start":"2026-02-13T22:42:20.094407Z","end":"2026-02-13T22:42:20.238608Z","steps":["trace[521168458] 'process raft request' (duration: 143.6618ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:22.539057Z","caller":"traceutil/trace.go:171","msg":"trace[1937418318] transaction","detail":"{read_only:false; response_revision:824; number_of_response:1; }","duration":"176.88805ms","start":"2026-02-13T22:42:22.362142Z","end":"2026-02-13T22:42:22.53903Z","steps":["trace[1937418318] 'process raft request' (duration: 176.712167ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:22.539636Z","caller":"traceutil/trace.go:171","msg":"trace[1029484784] linearizableReadLoop","detail":"{readStateIndex:858; appliedIndex:858; }","duration":"116.92989ms","start":"2026-02-13T22:42:22.422668Z","end":"2026-02-13T22:42:22.539598Z","steps":["trace[1029484784] 'read index received' (duration: 116.898999ms)","trace[1029484784] 'applied index is now lower than readState.Index' (duration: 27.621µs)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:42:22.539847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.155093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T22:42:22.539884Z","caller":"traceutil/trace.go:171","msg":"trace[1539853502] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:824; }","duration":"117.232764ms","start":"2026-02-13T22:42:22.422635Z","end":"2026-02-13T22:42:22.539867Z","steps":["trace[1539853502] 'agreement among raft nodes before linearized reading' (duration: 117.135313ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:42:22.734644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.548186ms","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-02-13T22:42:22.734779Z","caller":"traceutil/trace.go:171","msg":"trace[1438272849] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:825; }","duration":"119.698388ms","start":"2026-02-13T22:42:22.615063Z","end":"2026-02-13T22:42:22.734762Z","steps":["trace[1438272849] 'range keys from in-memory index tree' (duration: 119.532655ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:22.735323Z","caller":"traceutil/trace.go:171","msg":"trace[1330590758] linearizableReadLoop","detail":"{readStateIndex:860; appliedIndex:859; }","duration":"107.127605ms","start":"2026-02-13T22:42:22.628184Z","end":"2026-02-13T22:42:22.735312Z","steps":["trace[1330590758] 'read index received' (duration: 14.940333ms)","trace[1330590758] 'applied index is now lower than readState.Index' (duration: 92.186452ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:42:22.735441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.250658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-13T22:42:22.735461Z","caller":"traceutil/trace.go:171","msg":"trace[645267117] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:826; }","duration":"107.300508ms","start":"2026-02-13T22:42:22.628154Z","end":"2026-02-13T22:42:22.735455Z","steps":["trace[645267117] 'agreement among raft nodes before linearized reading' (duration: 107.192246ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:22.736574Z","caller":"traceutil/trace.go:171","msg":"trace[40969591] transaction","detail":"{read_only:false; response_revision:826; number_of_response:1; }","duration":"127.16035ms","start":"2026-02-13T22:42:22.6094Z","end":"2026-02-13T22:42:22.736561Z","steps":["trace[40969591] 'process raft request' (duration: 33.652735ms)","trace[40969591] 'compare' (duration: 91.889556ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:42:24.67951Z","caller":"traceutil/trace.go:171","msg":"trace[1671354055] transaction","detail":"{read_only:false; response_revision:830; number_of_response:1; }","duration":"114.929384ms","start":"2026-02-13T22:42:24.564554Z","end":"2026-02-13T22:42:24.679483Z","steps":["trace[1671354055] 'process raft request' (duration: 49.275299ms)","trace[1671354055] 'compare' (duration: 65.541083ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:42:24.892083Z","caller":"traceutil/trace.go:171","msg":"trace[1217006929] transaction","detail":"{read_only:false; response_revision:831; number_of_response:1; }","duration":"150.131818ms","start":"2026-02-13T22:42:24.741938Z","end":"2026-02-13T22:42:24.89207Z","steps":["trace[1217006929] 'process raft request' (duration: 150.027367ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:42:47.030038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.720114ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T22:42:47.030475Z","caller":"traceutil/trace.go:171","msg":"trace[216357413] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"239.850014ms","start":"2026-02-13T22:42:46.790613Z","end":"2026-02-13T22:42:47.030463Z","steps":["trace[216357413] 'process raft request' (duration: 34.639183ms)","trace[216357413] 'compare' (duration: 204.635103ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:42:49.445298Z","caller":"traceutil/trace.go:171","msg":"trace[547185033] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"154.494706ms","start":"2026-02-13T22:42:49.290785Z","end":"2026-02-13T22:42:49.44528Z","steps":["trace[547185033] 'process raft request' (duration: 154.193591ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:50.575671Z","caller":"traceutil/trace.go:171","msg":"trace[1767627395] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"146.598716ms","start":"2026-02-13T22:42:50.429052Z","end":"2026-02-13T22:42:50.575651Z","steps":["trace[1767627395] 'process raft request' (duration: 146.489904ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:42:51.249205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.817405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-13T22:42:51.24926Z","caller":"traceutil/trace.go:171","msg":"trace[41325193] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:904; }","duration":"109.908306ms","start":"2026-02-13T22:42:51.139337Z","end":"2026-02-13T22:42:51.249245Z","steps":["trace[41325193] 'range keys from in-memory index tree' (duration: 109.700163ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:54.763046Z","caller":"traceutil/trace.go:171","msg":"trace[270582203] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"167.210628ms","start":"2026-02-13T22:42:54.595819Z","end":"2026-02-13T22:42:54.76303Z","steps":["trace[270582203] 'process raft request' (duration: 167.113016ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:55.685512Z","caller":"traceutil/trace.go:171","msg":"trace[1879012831] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"233.905483ms","start":"2026-02-13T22:42:55.451589Z","end":"2026-02-13T22:42:55.685494Z","steps":["trace[1879012831] 'process raft request' (duration: 233.816011ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:55.685943Z","caller":"traceutil/trace.go:171","msg":"trace[935216633] linearizableReadLoop","detail":"{readStateIndex:958; appliedIndex:958; }","duration":"197.288047ms","start":"2026-02-13T22:42:55.488647Z","end":"2026-02-13T22:42:55.685935Z","steps":["trace[935216633] 'read index received' (duration: 197.284497ms)","trace[935216633] 'applied index is now lower than readState.Index' (duration: 2.67µs)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:42:55.686107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.622898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-13T22:42:55.686134Z","caller":"traceutil/trace.go:171","msg":"trace[1865166922] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:918; }","duration":"116.680648ms","start":"2026-02-13T22:42:55.569446Z","end":"2026-02-13T22:42:55.686127Z","steps":["trace[1865166922] 'agreement among raft nodes before linearized reading' (duration: 116.602086ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:42:55.686295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.374238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T22:42:55.686321Z","caller":"traceutil/trace.go:171","msg":"trace[61399881] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:918; }","duration":"197.705743ms","start":"2026-02-13T22:42:55.488607Z","end":"2026-02-13T22:42:55.686313Z","steps":["trace[61399881] 'agreement among raft nodes before linearized reading' (duration: 197.394898ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:42:57.077572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.6933ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-13T22:42:57.077668Z","caller":"traceutil/trace.go:171","msg":"trace[148463440] linearizableReadLoop","detail":"{readStateIndex:964; appliedIndex:963; }","duration":"158.448681ms","start":"2026-02-13T22:42:56.919201Z","end":"2026-02-13T22:42:57.07765Z","steps":["trace[148463440] 'read index received' (duration: 30.621868ms)","trace[148463440] 'applied index is now lower than readState.Index' (duration: 127.825223ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:42:57.077808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.592053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T22:42:57.077868Z","caller":"traceutil/trace.go:171","msg":"trace[538498979] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:0; response_revision:923; }","duration":"158.657534ms","start":"2026-02-13T22:42:56.919198Z","end":"2026-02-13T22:42:57.077855Z","steps":["trace[538498979] 'agreement among raft nodes before linearized reading' (duration: 158.536172ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:58.081475Z","caller":"traceutil/trace.go:171","msg":"trace[159842679] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"224.667012ms","start":"2026-02-13T22:42:57.85679Z","end":"2026-02-13T22:42:58.081457Z","steps":["trace[159842679] 'process raft request' (duration: 181.46715ms)","trace[159842679] 'compare' (duration: 43.008169ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:42:59.185072Z","caller":"traceutil/trace.go:171","msg":"trace[1167896869] linearizableReadLoop","detail":"{readStateIndex:979; appliedIndex:978; }","duration":"267.279032ms","start":"2026-02-13T22:42:58.917771Z","end":"2026-02-13T22:42:59.18505Z","steps":["trace[1167896869] 'read index received' (duration: 267.083868ms)","trace[1167896869] 'applied index is now lower than readState.Index' (duration: 193.983µs)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:42:59.18538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.561415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-13T22:42:59.185438Z","caller":"traceutil/trace.go:171","msg":"trace[1453571629] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:938; }","duration":"267.701588ms","start":"2026-02-13T22:42:58.917723Z","end":"2026-02-13T22:42:59.185424Z","steps":["trace[1453571629] 'agreement among raft nodes before linearized reading' (duration: 267.411504ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:59.185642Z","caller":"traceutil/trace.go:171","msg":"trace[834302316] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"289.683508ms","start":"2026-02-13T22:42:58.895938Z","end":"2026-02-13T22:42:59.185622Z","steps":["trace[834302316] 'process raft request' (duration: 288.989398ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:42:59.353279Z","caller":"traceutil/trace.go:171","msg":"trace[246812756] linearizableReadLoop","detail":"{readStateIndex:980; appliedIndex:979; }","duration":"153.443491ms","start":"2026-02-13T22:42:59.199821Z","end":"2026-02-13T22:42:59.353265Z","steps":["trace[246812756] 'read index received' (duration: 111.779834ms)","trace[246812756] 'applied index is now lower than readState.Index' (duration: 41.663097ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:42:59.353357Z","caller":"traceutil/trace.go:171","msg":"trace[923552371] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"163.218749ms","start":"2026-02-13T22:42:59.19013Z","end":"2026-02-13T22:42:59.353348Z","steps":["trace[923552371] 'process raft request' (duration: 121.460291ms)","trace[923552371] 'compare' (duration: 41.601936ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:42:59.353996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.160111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-13T22:42:59.356161Z","caller":"traceutil/trace.go:171","msg":"trace[1406737016] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:939; }","duration":"154.232922ms","start":"2026-02-13T22:42:59.199797Z","end":"2026-02-13T22:42:59.35403Z","steps":["trace[1406737016] 'agreement among raft nodes before linearized reading' (duration: 154.11423ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:43:01.115836Z","caller":"traceutil/trace.go:171","msg":"trace[976478063] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"129.365475ms","start":"2026-02-13T22:43:00.986452Z","end":"2026-02-13T22:43:01.115818Z","steps":["trace[976478063] 'process raft request' (duration: 129.239224ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:43:07.860075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.084169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-13T22:43:07.860147Z","caller":"traceutil/trace.go:171","msg":"trace[2135346879] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:981; }","duration":"465.19124ms","start":"2026-02-13T22:43:07.39494Z","end":"2026-02-13T22:43:07.860131Z","steps":["trace[2135346879] 'range keys from in-memory index tree' (duration: 464.949317ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:43:07.860189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:43:07.394924Z","time spent":"465.251981ms","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-13T22:43:07.860473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.600822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T22:43:07.860503Z","caller":"traceutil/trace.go:171","msg":"trace[1636814807] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:981; }","duration":"436.657293ms","start":"2026-02-13T22:43:07.423836Z","end":"2026-02-13T22:43:07.860493Z","steps":["trace[1636814807] 'range keys from in-memory index tree' (duration: 436.550931ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:43:07.860528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:43:07.423821Z","time spent":"436.701013ms","remote":"127.0.0.1:41750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-13T22:43:07.86068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.85142ms","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-13T22:43:07.86077Z","caller":"traceutil/trace.go:171","msg":"trace[1217282666] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:981; }","duration":"395.985813ms","start":"2026-02-13T22:43:07.464765Z","end":"2026-02-13T22:43:07.86075Z","steps":["trace[1217282666] 'range keys from in-memory index tree' (duration: 395.181912ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:43:07.86137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:43:07.464756Z","time spent":"396.596821ms","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-13T22:43:07.861637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.756336ms","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-02-13T22:43:07.861679Z","caller":"traceutil/trace.go:171","msg":"trace[1343916992] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:981; }","duration":"397.840888ms","start":"2026-02-13T22:43:07.463827Z","end":"2026-02-13T22:43:07.861668Z","steps":["trace[1343916992] 'range keys from in-memory index tree' (duration: 396.637331ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:43:07.861709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:43:07.463819Z","time spent":"397.882859ms","remote":"127.0.0.1:39232","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-02-13T22:43:12.04215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.203625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-13T22:43:12.042198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.909672ms","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-13T22:43:12.042233Z","caller":"traceutil/trace.go:171","msg":"trace[1105454166] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:993; }","duration":"141.330737ms","start":"2026-02-13T22:43:11.900884Z","end":"2026-02-13T22:43:12.042215Z","steps":["trace[1105454166] 'range keys from in-memory index tree' (duration: 141.033813ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:43:12.042247Z","caller":"traceutil/trace.go:171","msg":"trace[1552648025] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:993; }","duration":"138.012552ms","start":"2026-02-13T22:43:11.904221Z","end":"2026-02-13T22:43:12.042233Z","steps":["trace[1552648025] 'range keys from in-memory index tree' (duration: 137.75555ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:43:12.04244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.958609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-13T22:43:12.042455Z","caller":"traceutil/trace.go:171","msg":"trace[1409539054] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:993; }","duration":"142.991769ms","start":"2026-02-13T22:43:11.899458Z","end":"2026-02-13T22:43:12.04245Z","steps":["trace[1409539054] 'range keys from in-memory index tree' (duration: 142.900788ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:43:12.042515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.134214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-13T22:43:12.042536Z","caller":"traceutil/trace.go:171","msg":"trace[718232696] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:993; }","duration":"144.184784ms","start":"2026-02-13T22:43:11.898338Z","end":"2026-02-13T22:43:12.042523Z","steps":["trace[718232696] 'range keys from in-memory index tree' (duration: 144.049693ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:43:12.214257Z","caller":"traceutil/trace.go:171","msg":"trace[1407078437] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"166.539875ms","start":"2026-02-13T22:43:12.047692Z","end":"2026-02-13T22:43:12.214232Z","steps":["trace[1407078437] 'process raft request' (duration: 166.469924ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:43:12.215377Z","caller":"traceutil/trace.go:171","msg":"trace[713951709] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"167.637519ms","start":"2026-02-13T22:43:12.047661Z","end":"2026-02-13T22:43:12.215298Z","steps":["trace[713951709] 'process raft request' (duration: 166.433553ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:43:12.215008Z","caller":"traceutil/trace.go:171","msg":"trace[1357868260] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"167.402786ms","start":"2026-02-13T22:43:12.047589Z","end":"2026-02-13T22:43:12.214992Z","steps":["trace[1357868260] 'process raft request' (duration: 109.012203ms)","trace[1357868260] 'compare' (duration: 57.362979ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:43:12.590003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.567199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T22:43:12.590093Z","caller":"traceutil/trace.go:171","msg":"trace[1264219323] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:998; }","duration":"164.703911ms","start":"2026-02-13T22:43:12.42537Z","end":"2026-02-13T22:43:12.590074Z","steps":["trace[1264219323] 'range keys from in-memory index tree' (duration: 164.505448ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:43:12.692994Z","caller":"traceutil/trace.go:171","msg":"trace[792979575] linearizableReadLoop","detail":"{readStateIndex:1044; appliedIndex:1043; }","duration":"101.538844ms","start":"2026-02-13T22:43:12.591433Z","end":"2026-02-13T22:43:12.692972Z","steps":["trace[792979575] 'read index received' (duration: 101.355432ms)","trace[792979575] 'applied index is now lower than readState.Index' (duration: 182.512µs)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:43:12.69303Z","caller":"traceutil/trace.go:171","msg":"trace[1972701037] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"103.209116ms","start":"2026-02-13T22:43:12.589798Z","end":"2026-02-13T22:43:12.693007Z","steps":["trace[1972701037] 'process raft request' (duration: 103.053474ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:43:12.693134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.672947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T22:43:12.693178Z","caller":"traceutil/trace.go:171","msg":"trace[357817963] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:999; }","duration":"101.758498ms","start":"2026-02-13T22:43:12.591405Z","end":"2026-02-13T22:43:12.693164Z","steps":["trace[357817963] 'agreement among raft nodes before linearized reading' (duration: 101.656087ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:43:14.342186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.049623ms","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-13T22:43:14.342351Z","caller":"traceutil/trace.go:171","msg":"trace[2006921337] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1002; }","duration":"113.250936ms","start":"2026-02-13T22:43:14.229079Z","end":"2026-02-13T22:43:14.34233Z","steps":["trace[2006921337] 'range keys from in-memory index tree' (duration: 112.905461ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:43:14.342774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.777192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-13T22:43:14.342996Z","caller":"traceutil/trace.go:171","msg":"trace[1634074893] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1002; }","duration":"117.001474ms","start":"2026-02-13T22:43:14.225981Z","end":"2026-02-13T22:43:14.342982Z","steps":["trace[1634074893] 'range keys from in-memory index tree' (duration: 116.66238ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:43:14.343728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.365031ms","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-02-13T22:43:14.343908Z","caller":"traceutil/trace.go:171","msg":"trace[202442691] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1002; }","duration":"114.548533ms","start":"2026-02-13T22:43:14.229337Z","end":"2026-02-13T22:43:14.343886Z","steps":["trace[202442691] 'range keys from in-memory index tree' (duration: 114.26677ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:43:14.482561Z","caller":"traceutil/trace.go:171","msg":"trace[1707747381] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"130.767206ms","start":"2026-02-13T22:43:14.351767Z","end":"2026-02-13T22:43:14.482534Z","steps":["trace[1707747381] 'process raft request' (duration: 125.185552ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:43:14.483106Z","caller":"traceutil/trace.go:171","msg":"trace[70341906] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"131.233951ms","start":"2026-02-13T22:43:14.351855Z","end":"2026-02-13T22:43:14.483089Z","steps":["trace[70341906] 'process raft request' (duration: 129.961745ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:43:18.748976Z","caller":"traceutil/trace.go:171","msg":"trace[470308743] linearizableReadLoop","detail":"{readStateIndex:1065; appliedIndex:1064; }","duration":"145.02205ms","start":"2026-02-13T22:43:18.603917Z","end":"2026-02-13T22:43:18.748939Z","steps":["trace[470308743] 'read index received' (duration: 102.058156ms)","trace[470308743] 'applied index is now lower than readState.Index' (duration: 42.961994ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:43:18.749146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.200293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T22:43:18.749163Z","caller":"traceutil/trace.go:171","msg":"trace[1891579537] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"245.548077ms","start":"2026-02-13T22:43:18.503583Z","end":"2026-02-13T22:43:18.749131Z","steps":["trace[1891579537] 'process raft request' (duration: 202.413691ms)","trace[1891579537] 'compare' (duration: 42.500168ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:43:18.749205Z","caller":"traceutil/trace.go:171","msg":"trace[1396731065] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1019; }","duration":"145.308944ms","start":"2026-02-13T22:43:18.603884Z","end":"2026-02-13T22:43:18.749193Z","steps":["trace[1396731065] 'agreement among raft nodes before linearized reading' (duration: 145.177363ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:43:19.756015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.197895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-13T22:43:19.756098Z","caller":"traceutil/trace.go:171","msg":"trace[40018214] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1019; }","duration":"376.323896ms","start":"2026-02-13T22:43:19.379758Z","end":"2026-02-13T22:43:19.756081Z","steps":["trace[40018214] 'range keys from in-memory index tree' (duration: 376.059142ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:43:19.756136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:43:19.379739Z","time spent":"376.388057ms","remote":"127.0.0.1:39232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-13T22:43:19.756596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.430878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T22:43:19.756651Z","caller":"traceutil/trace.go:171","msg":"trace[982690599] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1019; }","duration":"331.51909ms","start":"2026-02-13T22:43:19.425122Z","end":"2026-02-13T22:43:19.756641Z","steps":["trace[982690599] 'range keys from in-memory index tree' (duration: 331.374668ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:43:19.756938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T22:43:19.425105Z","time spent":"331.742762ms","remote":"127.0.0.1:41750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-13T22:43:20.741281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.115647ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T22:43:20.741826Z","caller":"traceutil/trace.go:171","msg":"trace[259912475] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"179.144292ms","start":"2026-02-13T22:43:20.562603Z","end":"2026-02-13T22:43:20.741747Z","steps":["trace[259912475] 'process raft request' (duration: 47.447957ms)","trace[259912475] 'compare' (duration: 130.968725ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:43:38.984594Z","caller":"traceutil/trace.go:171","msg":"trace[799125699] linearizableReadLoop","detail":"{readStateIndex:1128; appliedIndex:1127; }","duration":"141.905111ms","start":"2026-02-13T22:43:38.842667Z","end":"2026-02-13T22:43:38.984572Z","steps":["trace[799125699] 'read index received' (duration: 141.75199ms)","trace[799125699] 'applied index is now lower than readState.Index' (duration: 152.171µs)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:43:38.984855Z","caller":"traceutil/trace.go:171","msg":"trace[669593390] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"193.732092ms","start":"2026-02-13T22:43:38.791097Z","end":"2026-02-13T22:43:38.984829Z","steps":["trace[669593390] 'process raft request' (duration: 193.338288ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:43:38.985209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.523398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/default/\" range_end:\"/registry/roles/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T22:43:38.985257Z","caller":"traceutil/trace.go:171","msg":"trace[1355658254] range","detail":"{range_begin:/registry/roles/default/; range_end:/registry/roles/default0; response_count:0; response_revision:1078; }","duration":"142.588169ms","start":"2026-02-13T22:43:38.842659Z","end":"2026-02-13T22:43:38.985247Z","steps":["trace[1355658254] 'agreement among raft nodes before linearized reading' (duration: 142.464838ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:43:38.986703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.595107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-node-lease/\" range_end:\"/registry/roles/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T22:43:38.98675Z","caller":"traceutil/trace.go:171","msg":"trace[263471119] range","detail":"{range_begin:/registry/roles/kube-node-lease/; range_end:/registry/roles/kube-node-lease0; response_count:0; response_revision:1078; }","duration":"131.668608ms","start":"2026-02-13T22:43:38.855069Z","end":"2026-02-13T22:43:38.986737Z","steps":["trace[263471119] 'agreement among raft nodes before linearized reading' (duration: 131.582407ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:43:39.163286Z","caller":"traceutil/trace.go:171","msg":"trace[1878507411] linearizableReadLoop","detail":"{readStateIndex:1129; appliedIndex:1128; }","duration":"114.270386ms","start":"2026-02-13T22:43:39.048992Z","end":"2026-02-13T22:43:39.163262Z","steps":["trace[1878507411] 'read index received' (duration: 62.247914ms)","trace[1878507411] 'applied index is now lower than readState.Index' (duration: 52.021322ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T22:43:39.16381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.802742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/default/\" range_end:\"/registry/secrets/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T22:43:39.163858Z","caller":"traceutil/trace.go:171","msg":"trace[1836969805] range","detail":"{range_begin:/registry/secrets/default/; range_end:/registry/secrets/default0; response_count:0; response_revision:1079; }","duration":"114.864662ms","start":"2026-02-13T22:43:39.048983Z","end":"2026-02-13T22:43:39.163848Z","steps":["trace[1836969805] 'agreement among raft nodes before linearized reading' (duration: 114.777311ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T22:43:39.164296Z","caller":"traceutil/trace.go:171","msg":"trace[843477236] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"155.453047ms","start":"2026-02-13T22:43:39.008827Z","end":"2026-02-13T22:43:39.16428Z","steps":["trace[843477236] 'process raft request' (duration: 102.461305ms)","trace[843477236] 'compare' (duration: 51.872879ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:43:40.10189Z","caller":"traceutil/trace.go:171","msg":"trace[1336995836] linearizableReadLoop","detail":"{readStateIndex:1131; appliedIndex:1130; }","duration":"117.246967ms","start":"2026-02-13T22:43:39.984618Z","end":"2026-02-13T22:43:40.101865Z","steps":["trace[1336995836] 'read index received' (duration: 116.790491ms)","trace[1336995836] 'applied index is now lower than readState.Index' (duration: 455.106µs)"],"step_count":2} {"level":"info","ts":"2026-02-13T22:43:40.102218Z","caller":"traceutil/trace.go:171","msg":"trace[576109289] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"120.579377ms","start":"2026-02-13T22:43:39.981623Z","end":"2026-02-13T22:43:40.102202Z","steps":["trace[576109289] 'process raft request' (duration: 119.903119ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:43:40.102597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.847204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" limit:500 ","response":"range_response_count:2 size:8877"} {"level":"info","ts":"2026-02-13T22:43:40.102674Z","caller":"traceutil/trace.go:171","msg":"trace[921157268] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:2; response_revision:1081; }","duration":"117.972935ms","start":"2026-02-13T22:43:39.984683Z","end":"2026-02-13T22:43:40.102656Z","steps":["trace[921157268] 'agreement among raft nodes before linearized reading' (duration: 117.712552ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:43:40.103108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.617784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:1 size:3017"} {"level":"info","ts":"2026-02-13T22:43:40.103153Z","caller":"traceutil/trace.go:171","msg":"trace[926371073] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:1; response_revision:1081; }","duration":"103.680065ms","start":"2026-02-13T22:43:39.999463Z","end":"2026-02-13T22:43:40.103143Z","steps":["trace[926371073] 'agreement among raft nodes before linearized reading' (duration: 103.601974ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T22:43:40.103238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.493141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/coredns\" ","response":"range_response_count:1 size:612"} {"level":"info","ts":"2026-02-13T22:43:40.103351Z","caller":"traceutil/trace.go:171","msg":"trace[288498464] range","detail":"{range_begin:/registry/configmaps/kube-system/coredns; range_end:; response_count:1; response_revision:1081; }","duration":"118.729454ms","start":"2026-02-13T22:43:39.984605Z","end":"2026-02-13T22:43:40.103335Z","steps":["trace[288498464] 'agreement among raft nodes before linearized reading' (duration: 118.464411ms)"],"step_count":1}