{"level":"warn","ts":"2026-02-17T14:58:03.488435Z","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-17T14:58:03.488546Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.141:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.141:2380","--initial-cluster=instance=https://199.204.45.141:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.141:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.141: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-17T14:58:03.488644Z","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-17T14:58:03.488658Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-02-17T14:58:03.488683Z","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-17T14:58:03.489451Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"]} {"level":"info","ts":"2026-02-17T14:58:03.489538Z","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://199.204.45.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.141: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-17T14:58:03.494472Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.67998ms"} {"level":"info","ts":"2026-02-17T14:58:03.511128Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9ef3b4f68930dc2","cluster-id":"b19a5957e6e65747"} {"level":"info","ts":"2026-02-17T14:58:03.511212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=()"} {"level":"info","ts":"2026-02-17T14:58:03.511236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 0"} {"level":"info","ts":"2026-02-17T14:58:03.511249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9ef3b4f68930dc2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-17T14:58:03.511258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 1"} {"level":"info","ts":"2026-02-17T14:58:03.511294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"warn","ts":"2026-02-17T14:58:03.517722Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-17T14:58:03.52692Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-17T14:58:03.529776Z","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-17T14:58:03.532009Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9ef3b4f68930dc2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-17T14:58:03.53688Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9ef3b4f68930dc2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-17T14:58:03.537128Z","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-17T14:58:03.538245Z","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-17T14:58:03.538356Z","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-17T14:58:03.538248Z","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-17T14:58:03.543456Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9ef3b4f68930dc2","initial-advertise-peer-urls":["https://199.204.45.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-17T14:58:03.54407Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-17T14:58:03.538281Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-02-17T14:58:03.544327Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-02-17T14:58:03.539623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"info","ts":"2026-02-17T14:58:03.544675Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","added-peer-id":"9ef3b4f68930dc2","added-peer-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-02-17T14:58:04.415137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 is starting a new election at term 1"} {"level":"info","ts":"2026-02-17T14:58:04.415202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-17T14:58:04.415227Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgPreVoteResp from 9ef3b4f68930dc2 at term 1"} {"level":"info","ts":"2026-02-17T14:58:04.415241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became candidate at term 2"} {"level":"info","ts":"2026-02-17T14:58:04.415246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgVoteResp from 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-02-17T14:58:04.415254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became leader at term 2"} {"level":"info","ts":"2026-02-17T14:58:04.415262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9ef3b4f68930dc2 elected leader 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-02-17T14:58:04.439466Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T14:58:04.441576Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9ef3b4f68930dc2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.141:2379]}","request-path":"/0/members/9ef3b4f68930dc2/attributes","cluster-id":"b19a5957e6e65747","publish-timeout":"7s"} {"level":"info","ts":"2026-02-17T14:58:04.441618Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T14:58:04.443589Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.141:2379"} {"level":"info","ts":"2026-02-17T14:58:04.443861Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T14:58:04.443924Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T14:58:04.443943Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T14:58:04.443955Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T14:58:04.445092Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-17T14:58:04.467118Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-17T14:58:04.467138Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-17T14:58:08.14185Z","caller":"traceutil/trace.go:171","msg":"trace[1591183733] transaction","detail":"{read_only:false; response_revision:191; number_of_response:1; }","duration":"112.026273ms","start":"2026-02-17T14:58:08.029787Z","end":"2026-02-17T14:58:08.141813Z","steps":["trace[1591183733] 'process raft request' (duration: 37.997965ms)","trace[1591183733] 'compare' (duration: 73.64629ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T14:58:10.010343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.646596ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T14:58:10.010906Z","caller":"traceutil/trace.go:171","msg":"trace[359111933] transaction","detail":"{read_only:false; response_revision:217; number_of_response:1; }","duration":"143.205642ms","start":"2026-02-17T14:58:09.867679Z","end":"2026-02-17T14:58:10.010885Z","steps":["trace[359111933] 'process raft request' (duration: 29.466223ms)","trace[359111933] 'compare' (duration: 111.972952ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T14:58:10.011605Z","caller":"traceutil/trace.go:171","msg":"trace[140057442] linearizableReadLoop","detail":"{readStateIndex:222; appliedIndex:221; }","duration":"119.577006ms","start":"2026-02-17T14:58:09.891993Z","end":"2026-02-17T14:58:10.01157Z","steps":["trace[140057442] 'read index received' (duration: 5.058589ms)","trace[140057442] 'applied index is now lower than readState.Index' (duration: 114.515677ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T14:58:10.017346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.347479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3397"} {"level":"info","ts":"2026-02-17T14:58:10.017415Z","caller":"traceutil/trace.go:171","msg":"trace[158340333] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:218; }","duration":"125.476022ms","start":"2026-02-17T14:58:09.891927Z","end":"2026-02-17T14:58:10.017404Z","steps":["trace[158340333] 'agreement among raft nodes before linearized reading' (duration: 119.770019ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:10.235811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.091885ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T14:58:10.236288Z","caller":"traceutil/trace.go:171","msg":"trace[1738918975] linearizableReadLoop","detail":"{readStateIndex:228; appliedIndex:226; }","duration":"134.059727ms","start":"2026-02-17T14:58:10.102208Z","end":"2026-02-17T14:58:10.236268Z","steps":["trace[1738918975] 'read index received' (duration: 8.416781ms)","trace[1738918975] 'applied index is now lower than readState.Index' (duration: 125.641866ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T14:58:10.237047Z","caller":"traceutil/trace.go:171","msg":"trace[2110981821] transaction","detail":"{read_only:false; response_revision:221; number_of_response:1; }","duration":"161.942185ms","start":"2026-02-17T14:58:10.075066Z","end":"2026-02-17T14:58:10.237008Z","steps":["trace[2110981821] 'process raft request' (duration: 35.585624ms)","trace[2110981821] 'compare' (duration: 124.897841ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T14:58:10.237074Z","caller":"traceutil/trace.go:171","msg":"trace[1060556643] transaction","detail":"{read_only:false; response_revision:222; number_of_response:1; }","duration":"161.22938ms","start":"2026-02-17T14:58:10.075814Z","end":"2026-02-17T14:58:10.237044Z","steps":["trace[1060556643] 'process raft request' (duration: 160.096706ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:10.23727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.128061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-q93heb\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T14:58:10.237876Z","caller":"traceutil/trace.go:171","msg":"trace[1666275569] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-q93heb; range_end:; response_count:0; response_revision:222; }","duration":"164.799766ms","start":"2026-02-17T14:58:10.073056Z","end":"2026-02-17T14:58:10.237856Z","steps":["trace[1666275569] 'agreement among raft nodes before linearized reading' (duration: 164.04695ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:10.237362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.059015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-17T14:58:10.238467Z","caller":"traceutil/trace.go:171","msg":"trace[914790125] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:222; }","duration":"134.19107ms","start":"2026-02-17T14:58:10.104261Z","end":"2026-02-17T14:58:10.238452Z","steps":["trace[914790125] 'agreement among raft nodes before linearized reading' (duration: 133.067065ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:10.39721Z","caller":"traceutil/trace.go:171","msg":"trace[1398487113] transaction","detail":"{read_only:false; response_revision:228; number_of_response:1; }","duration":"142.64085ms","start":"2026-02-17T14:58:10.25454Z","end":"2026-02-17T14:58:10.397181Z","steps":["trace[1398487113] 'process raft request' (duration: 142.60335ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:10.397851Z","caller":"traceutil/trace.go:171","msg":"trace[1042258208] transaction","detail":"{read_only:false; response_revision:224; number_of_response:1; }","duration":"153.044432ms","start":"2026-02-17T14:58:10.244793Z","end":"2026-02-17T14:58:10.397837Z","steps":["trace[1042258208] 'process raft request' (duration: 152.201815ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:10.398157Z","caller":"traceutil/trace.go:171","msg":"trace[1503834439] transaction","detail":"{read_only:false; response_revision:225; number_of_response:1; }","duration":"150.842946ms","start":"2026-02-17T14:58:10.247303Z","end":"2026-02-17T14:58:10.398146Z","steps":["trace[1503834439] 'process raft request' (duration: 149.734391ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:10.398593Z","caller":"traceutil/trace.go:171","msg":"trace[2142452268] transaction","detail":"{read_only:false; response_revision:226; number_of_response:1; }","duration":"147.250429ms","start":"2026-02-17T14:58:10.25133Z","end":"2026-02-17T14:58:10.398581Z","steps":["trace[2142452268] 'process raft request' (duration: 145.738466ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:10.398861Z","caller":"traceutil/trace.go:171","msg":"trace[764484535] transaction","detail":"{read_only:false; response_revision:227; number_of_response:1; }","duration":"145.336148ms","start":"2026-02-17T14:58:10.253513Z","end":"2026-02-17T14:58:10.39885Z","steps":["trace[764484535] 'process raft request' (duration: 143.60049ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:10.399504Z","caller":"traceutil/trace.go:171","msg":"trace[1815354508] transaction","detail":"{read_only:false; response_revision:223; number_of_response:1; }","duration":"154.435263ms","start":"2026-02-17T14:58:10.245055Z","end":"2026-02-17T14:58:10.39949Z","steps":["trace[1815354508] 'process raft request' (duration: 119.153656ms)","trace[1815354508] 'compare' (duration: 32.678631ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T14:58:10.773663Z","caller":"traceutil/trace.go:171","msg":"trace[275253955] transaction","detail":"{read_only:false; response_revision:242; number_of_response:1; }","duration":"101.762584ms","start":"2026-02-17T14:58:10.671873Z","end":"2026-02-17T14:58:10.773636Z","steps":["trace[275253955] 'process raft request' (duration: 64.959783ms)","trace[275253955] 'compare' (duration: 36.700369ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T14:58:11.530514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.818298ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T14:58:11.530745Z","caller":"traceutil/trace.go:171","msg":"trace[1604763055] transaction","detail":"{read_only:false; number_of_response:0; response_revision:260; }","duration":"305.839572ms","start":"2026-02-17T14:58:11.22489Z","end":"2026-02-17T14:58:11.530729Z","steps":["trace[1604763055] 'process raft request' (duration: 305.789291ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:11.530813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:11.224878Z","time spent":"305.911293ms","remote":"127.0.0.1:46302","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T14:58:11.531209Z","caller":"traceutil/trace.go:171","msg":"trace[118997201] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"341.873025ms","start":"2026-02-17T14:58:11.189322Z","end":"2026-02-17T14:58:11.531195Z","steps":["trace[118997201] 'process raft request' (duration: 154.28696ms)","trace[118997201] 'compare' (duration: 186.661815ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T14:58:11.531268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:11.189308Z","time spent":"341.936066ms","remote":"127.0.0.1:46320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1196,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T14:58:11.531457Z","caller":"traceutil/trace.go:171","msg":"trace[1558421538] transaction","detail":"{read_only:false; response_revision:260; number_of_response:1; }","duration":"324.41553ms","start":"2026-02-17T14:58:11.207032Z","end":"2026-02-17T14:58:11.531448Z","steps":["trace[1558421538] 'process raft request' (duration: 323.590583ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:11.531499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:11.20702Z","time spent":"324.459902ms","remote":"127.0.0.1:46324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":182,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T14:58:11.531693Z","caller":"traceutil/trace.go:171","msg":"trace[597229744] transaction","detail":"{read_only:false; number_of_response:0; response_revision:263; }","duration":"286.19078ms","start":"2026-02-17T14:58:11.245477Z","end":"2026-02-17T14:58:11.531668Z","steps":["trace[597229744] 'process raft request' (duration: 286.161679ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:11.531778Z","caller":"traceutil/trace.go:171","msg":"trace[1172318383] transaction","detail":"{read_only:false; number_of_response:0; response_revision:262; }","duration":"290.311938ms","start":"2026-02-17T14:58:11.241458Z","end":"2026-02-17T14:58:11.53177Z","steps":["trace[1172318383] 'process raft request' (duration: 290.060443ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:11.531935Z","caller":"traceutil/trace.go:171","msg":"trace[1114632693] transaction","detail":"{read_only:false; number_of_response:0; response_revision:262; }","duration":"290.39081ms","start":"2026-02-17T14:58:11.24152Z","end":"2026-02-17T14:58:11.531911Z","steps":["trace[1114632693] 'process raft request' (duration: 290.029942ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:11.532002Z","caller":"traceutil/trace.go:171","msg":"trace[903985622] transaction","detail":"{read_only:false; response_revision:261; number_of_response:1; }","duration":"300.653081ms","start":"2026-02-17T14:58:11.231337Z","end":"2026-02-17T14:58:11.53199Z","steps":["trace[903985622] 'process raft request' (duration: 300.024567ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:11.532053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:11.231328Z","time spent":"300.701731ms","remote":"127.0.0.1:46208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T14:58:11.53208Z","caller":"traceutil/trace.go:171","msg":"trace[1272136280] transaction","detail":"{read_only:false; number_of_response:0; response_revision:262; }","duration":"289.165314ms","start":"2026-02-17T14:58:11.242907Z","end":"2026-02-17T14:58:11.532072Z","steps":["trace[1272136280] 'process raft request' (duration: 288.667894ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:11.532225Z","caller":"traceutil/trace.go:171","msg":"trace[431749937] transaction","detail":"{read_only:false; response_revision:262; number_of_response:1; }","duration":"298.254898ms","start":"2026-02-17T14:58:11.233961Z","end":"2026-02-17T14:58:11.532216Z","steps":["trace[431749937] 'process raft request' (duration: 297.516353ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:11.532259Z","caller":"traceutil/trace.go:171","msg":"trace[1779897444] transaction","detail":"{read_only:false; response_revision:263; number_of_response:1; }","duration":"286.810663ms","start":"2026-02-17T14:58:11.245439Z","end":"2026-02-17T14:58:11.532249Z","steps":["trace[1779897444] 'process raft request' (duration: 286.154409ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:11.808032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.890446ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T14:58:11.808254Z","caller":"traceutil/trace.go:171","msg":"trace[695255300] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"185.657012ms","start":"2026-02-17T14:58:11.622467Z","end":"2026-02-17T14:58:11.808124Z","steps":["trace[695255300] 'process raft request' (duration: 63.610073ms)","trace[695255300] 'compare' (duration: 121.751073ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T14:58:11.818101Z","caller":"traceutil/trace.go:171","msg":"trace[1724072807] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"195.422052ms","start":"2026-02-17T14:58:11.622664Z","end":"2026-02-17T14:58:11.818086Z","steps":["trace[1724072807] 'process raft request' (duration: 195.277909ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:11.818319Z","caller":"traceutil/trace.go:171","msg":"trace[687366319] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"190.004755ms","start":"2026-02-17T14:58:11.628304Z","end":"2026-02-17T14:58:11.818309Z","steps":["trace[687366319] 'process raft request' (duration: 189.723489ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:11.818594Z","caller":"traceutil/trace.go:171","msg":"trace[1235884576] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"190.022567ms","start":"2026-02-17T14:58:11.628564Z","end":"2026-02-17T14:58:11.818587Z","steps":["trace[1235884576] 'process raft request' (duration: 189.508915ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:12.538258Z","caller":"traceutil/trace.go:171","msg":"trace[663596267] linearizableReadLoop","detail":"{readStateIndex:292; appliedIndex:290; }","duration":"217.029126ms","start":"2026-02-17T14:58:12.321203Z","end":"2026-02-17T14:58:12.538232Z","steps":["trace[663596267] 'read index received' (duration: 216.73919ms)","trace[663596267] 'applied index is now lower than readState.Index' (duration: 288.856µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T14:58:12.538523Z","caller":"traceutil/trace.go:171","msg":"trace[1726443881] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"233.01852ms","start":"2026-02-17T14:58:12.305492Z","end":"2026-02-17T14:58:12.53851Z","steps":["trace[1726443881] 'process raft request' (duration: 232.669811ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:12.538968Z","caller":"traceutil/trace.go:171","msg":"trace[1149965343] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"236.635817ms","start":"2026-02-17T14:58:12.30232Z","end":"2026-02-17T14:58:12.538956Z","steps":["trace[1149965343] 'process raft request' (duration: 235.676226ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:12.539741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.518808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-02-17T14:58:12.539792Z","caller":"traceutil/trace.go:171","msg":"trace[1479046964] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:280; }","duration":"218.59782ms","start":"2026-02-17T14:58:12.321183Z","end":"2026-02-17T14:58:12.539781Z","steps":["trace[1479046964] 'agreement among raft nodes before linearized reading' (duration: 218.500008ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:12.541455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.671479ms","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-17T14:58:12.541501Z","caller":"traceutil/trace.go:171","msg":"trace[201479602] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:280; }","duration":"134.748531ms","start":"2026-02-17T14:58:12.406742Z","end":"2026-02-17T14:58:12.541491Z","steps":["trace[201479602] 'agreement among raft nodes before linearized reading' (duration: 134.677329ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:12.545607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.099798ms","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-17T14:58:12.545639Z","caller":"traceutil/trace.go:171","msg":"trace[1440510217] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:280; }","duration":"135.17345ms","start":"2026-02-17T14:58:12.410457Z","end":"2026-02-17T14:58:12.545631Z","steps":["trace[1440510217] 'agreement among raft nodes before linearized reading' (duration: 135.122759ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:12.546178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.727971ms","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-17T14:58:12.546207Z","caller":"traceutil/trace.go:171","msg":"trace[651139929] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:280; }","duration":"135.768022ms","start":"2026-02-17T14:58:12.410431Z","end":"2026-02-17T14:58:12.546199Z","steps":["trace[651139929] 'agreement among raft nodes before linearized reading' (duration: 135.724261ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:12.842304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.407601ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T14:58:12.842407Z","caller":"traceutil/trace.go:171","msg":"trace[996591568] linearizableReadLoop","detail":"{readStateIndex:293; appliedIndex:292; }","duration":"290.073823ms","start":"2026-02-17T14:58:12.552318Z","end":"2026-02-17T14:58:12.842392Z","steps":["trace[996591568] 'read index received' (duration: 129.306374ms)","trace[996591568] 'applied index is now lower than readState.Index' (duration: 160.766379ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T14:58:12.842466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.143065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-02-17T14:58:12.842496Z","caller":"traceutil/trace.go:171","msg":"trace[1648683354] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:281; }","duration":"290.184905ms","start":"2026-02-17T14:58:12.552303Z","end":"2026-02-17T14:58:12.842488Z","steps":["trace[1648683354] 'agreement among raft nodes before linearized reading' (duration: 290.131094ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:12.842677Z","caller":"traceutil/trace.go:171","msg":"trace[798960121] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"291.958464ms","start":"2026-02-17T14:58:12.550708Z","end":"2026-02-17T14:58:12.842666Z","steps":["trace[798960121] 'process raft request' (duration: 130.792457ms)","trace[798960121] 'compare' (duration: 160.308919ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T14:58:12.930343Z","caller":"traceutil/trace.go:171","msg":"trace[1837419683] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"373.590936ms","start":"2026-02-17T14:58:12.556735Z","end":"2026-02-17T14:58:12.930326Z","steps":["trace[1837419683] 'process raft request' (duration: 373.35135ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:12.93038Z","caller":"traceutil/trace.go:171","msg":"trace[427423558] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"375.193789ms","start":"2026-02-17T14:58:12.555168Z","end":"2026-02-17T14:58:12.930362Z","steps":["trace[427423558] 'process raft request' (duration: 374.820861ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:12.930435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:12.556729Z","time spent":"373.657717ms","remote":"127.0.0.1:46384","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-17T14:58:12.930477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:12.555148Z","time spent":"375.272201ms","remote":"127.0.0.1:46306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5255,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T14:58:12.930555Z","caller":"traceutil/trace.go:171","msg":"trace[39366540] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"373.013434ms","start":"2026-02-17T14:58:12.557533Z","end":"2026-02-17T14:58:12.930547Z","steps":["trace[39366540] 'process raft request' (duration: 372.579564ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:12.930589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:12.557527Z","time spent":"373.043985ms","remote":"127.0.0.1:46384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T14:58:13.119482Z","caller":"traceutil/trace.go:171","msg":"trace[40001474] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"180.136545ms","start":"2026-02-17T14:58:12.939315Z","end":"2026-02-17T14:58:13.119452Z","steps":["trace[40001474] 'process raft request' (duration: 149.510527ms)","trace[40001474] 'compare' (duration: 30.487145ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T14:58:13.120409Z","caller":"traceutil/trace.go:171","msg":"trace[1882087024] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"179.48987ms","start":"2026-02-17T14:58:12.940902Z","end":"2026-02-17T14:58:13.120392Z","steps":["trace[1882087024] 'process raft request' (duration: 179.395678ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:13.32661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.318114ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T14:58:13.326673Z","caller":"traceutil/trace.go:171","msg":"trace[387608455] linearizableReadLoop","detail":"{readStateIndex:300; appliedIndex:299; }","duration":"125.8574ms","start":"2026-02-17T14:58:13.200807Z","end":"2026-02-17T14:58:13.326664Z","steps":["trace[387608455] 'read index received' (duration: 24.392764ms)","trace[387608455] 'applied index is now lower than readState.Index' (duration: 101.464056ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T14:58:13.326784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.973083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3444"} {"level":"info","ts":"2026-02-17T14:58:13.326804Z","caller":"traceutil/trace.go:171","msg":"trace[1918035459] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:288; }","duration":"126.012783ms","start":"2026-02-17T14:58:13.200786Z","end":"2026-02-17T14:58:13.326799Z","steps":["trace[1918035459] 'agreement among raft nodes before linearized reading' (duration: 125.902391ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:13.327044Z","caller":"traceutil/trace.go:171","msg":"trace[543261270] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"187.718618ms","start":"2026-02-17T14:58:13.139302Z","end":"2026-02-17T14:58:13.32702Z","steps":["trace[543261270] 'process raft request' (duration: 85.933044ms)","trace[543261270] 'compare' (duration: 101.226452ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T14:58:15.077185Z","caller":"traceutil/trace.go:171","msg":"trace[928068744] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"129.195402ms","start":"2026-02-17T14:58:14.947972Z","end":"2026-02-17T14:58:15.077167Z","steps":["trace[928068744] 'process raft request' (duration: 86.042326ms)","trace[928068744] 'compare' (duration: 43.040284ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T14:58:15.077514Z","caller":"traceutil/trace.go:171","msg":"trace[1226963694] linearizableReadLoop","detail":"{readStateIndex:314; appliedIndex:312; }","duration":"120.380173ms","start":"2026-02-17T14:58:14.957126Z","end":"2026-02-17T14:58:15.077506Z","steps":["trace[1226963694] 'read index received' (duration: 76.826718ms)","trace[1226963694] 'applied index is now lower than readState.Index' (duration: 43.552695ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T14:58:15.077715Z","caller":"traceutil/trace.go:171","msg":"trace[397267220] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"127.999547ms","start":"2026-02-17T14:58:14.949707Z","end":"2026-02-17T14:58:15.077707Z","steps":["trace[397267220] 'process raft request' (duration: 127.764492ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:15.078033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.891724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-17T14:58:15.078099Z","caller":"traceutil/trace.go:171","msg":"trace[1871970499] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:302; }","duration":"120.991466ms","start":"2026-02-17T14:58:14.9571Z","end":"2026-02-17T14:58:15.078091Z","steps":["trace[1871970499] 'agreement among raft nodes before linearized reading' (duration: 120.891124ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:15.385125Z","caller":"traceutil/trace.go:171","msg":"trace[1840767227] linearizableReadLoop","detail":"{readStateIndex:317; appliedIndex:315; }","duration":"278.331832ms","start":"2026-02-17T14:58:15.106772Z","end":"2026-02-17T14:58:15.385104Z","steps":["trace[1840767227] 'read index received' (duration: 55.823017ms)","trace[1840767227] 'applied index is now lower than readState.Index' (duration: 222.507975ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T14:58:15.386204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.411655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-17T14:58:15.386309Z","caller":"traceutil/trace.go:171","msg":"trace[802736366] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:305; }","duration":"279.544788ms","start":"2026-02-17T14:58:15.106748Z","end":"2026-02-17T14:58:15.386293Z","steps":["trace[802736366] 'agreement among raft nodes before linearized reading' (duration: 279.385835ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:15.385551Z","caller":"traceutil/trace.go:171","msg":"trace[2009250744] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"293.097819ms","start":"2026-02-17T14:58:15.09244Z","end":"2026-02-17T14:58:15.385537Z","steps":["trace[2009250744] 'process raft request' (duration: 292.519347ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:15.386Z","caller":"traceutil/trace.go:171","msg":"trace[422382494] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"291.956443ms","start":"2026-02-17T14:58:15.09392Z","end":"2026-02-17T14:58:15.385876Z","steps":["trace[422382494] 'process raft request' (duration: 291.135796ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:15.633745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.190135ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T14:58:15.634001Z","caller":"traceutil/trace.go:171","msg":"trace[1682458439] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"237.69128ms","start":"2026-02-17T14:58:15.396285Z","end":"2026-02-17T14:58:15.633976Z","steps":["trace[1682458439] 'process raft request' (duration: 237.609458ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:15.634277Z","caller":"traceutil/trace.go:171","msg":"trace[1718314834] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"466.299386ms","start":"2026-02-17T14:58:15.167962Z","end":"2026-02-17T14:58:15.634262Z","steps":["trace[1718314834] 'process raft request' (duration: 354.490817ms)","trace[1718314834] 'compare' (duration: 111.001441ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T14:58:15.634347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:15.167948Z","time spent":"466.363497ms","remote":"127.0.0.1:46306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3355,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T14:58:15.634542Z","caller":"traceutil/trace.go:171","msg":"trace[1265526443] linearizableReadLoop","detail":"{readStateIndex:318; appliedIndex:317; }","duration":"248.42011ms","start":"2026-02-17T14:58:15.386111Z","end":"2026-02-17T14:58:15.634531Z","steps":["trace[1265526443] 'read index received' (duration: 136.349776ms)","trace[1265526443] 'applied index is now lower than readState.Index' (duration: 112.068904ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T14:58:15.634861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.064035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-17T14:58:15.634902Z","caller":"traceutil/trace.go:171","msg":"trace[1236849368] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:307; }","duration":"277.157656ms","start":"2026-02-17T14:58:15.357734Z","end":"2026-02-17T14:58:15.634891Z","steps":["trace[1236849368] 'agreement among raft nodes before linearized reading' (duration: 277.022923ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:15.636132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.850759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-02-17T14:58:15.639811Z","caller":"traceutil/trace.go:171","msg":"trace[1829295761] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:307; }","duration":"232.564309ms","start":"2026-02-17T14:58:15.407224Z","end":"2026-02-17T14:58:15.639788Z","steps":["trace[1829295761] 'agreement among raft nodes before linearized reading' (duration: 228.790878ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:15.637671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.967246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-02-17T14:58:15.641161Z","caller":"traceutil/trace.go:171","msg":"trace[914123329] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:307; }","duration":"333.066486ms","start":"2026-02-17T14:58:15.308077Z","end":"2026-02-17T14:58:15.641144Z","steps":["trace[914123329] 'agreement among raft nodes before linearized reading' (duration: 326.962145ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:15.641224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:15.308067Z","time spent":"333.144777ms","remote":"127.0.0.1:46324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":241,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-02-17T14:58:15.638067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.50954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-02-17T14:58:15.64155Z","caller":"traceutil/trace.go:171","msg":"trace[1161246335] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:307; }","duration":"484.039795ms","start":"2026-02-17T14:58:15.157502Z","end":"2026-02-17T14:58:15.641542Z","steps":["trace[1161246335] 'agreement among raft nodes before linearized reading' (duration: 480.51522ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:15.641764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:15.157487Z","time spent":"484.267821ms","remote":"127.0.0.1:46324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":218,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-02-17T14:58:15.638135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.81641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-02-17T14:58:15.647167Z","caller":"traceutil/trace.go:171","msg":"trace[221132894] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:307; }","duration":"389.874185ms","start":"2026-02-17T14:58:15.257282Z","end":"2026-02-17T14:58:15.647156Z","steps":["trace[221132894] 'agreement among raft nodes before linearized reading' (duration: 380.811631ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:15.647386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:15.257271Z","time spent":"390.044138ms","remote":"127.0.0.1:46324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-02-17T14:58:15.638215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.511315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-02-17T14:58:15.647793Z","caller":"traceutil/trace.go:171","msg":"trace[14857873] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:307; }","duration":"439.109801ms","start":"2026-02-17T14:58:15.208673Z","end":"2026-02-17T14:58:15.647783Z","steps":["trace[14857873] 'agreement among raft nodes before linearized reading' (duration: 429.484715ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:15.648032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:15.208578Z","time spent":"439.438099ms","remote":"127.0.0.1:46324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-02-17T14:58:15.638271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.677068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-02-17T14:58:15.648373Z","caller":"traceutil/trace.go:171","msg":"trace[163697209] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:307; }","duration":"535.794456ms","start":"2026-02-17T14:58:15.112568Z","end":"2026-02-17T14:58:15.648363Z","steps":["trace[163697209] 'agreement among raft nodes before linearized reading' (duration: 525.674409ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:15.648401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:15.112559Z","time spent":"535.833837ms","remote":"127.0.0.1:46548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-02-17T14:58:15.638324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.130274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-17T14:58:15.64875Z","caller":"traceutil/trace.go:171","msg":"trace[235937575] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:307; }","duration":"190.583289ms","start":"2026-02-17T14:58:15.458158Z","end":"2026-02-17T14:58:15.648741Z","steps":["trace[235937575] 'agreement among raft nodes before linearized reading' (duration: 180.142075ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:15.926994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.030543ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T14:58:15.92768Z","caller":"traceutil/trace.go:171","msg":"trace[842052643] linearizableReadLoop","detail":"{readStateIndex:325; appliedIndex:319; }","duration":"267.802995ms","start":"2026-02-17T14:58:15.659859Z","end":"2026-02-17T14:58:15.927662Z","steps":["trace[842052643] 'read index received' (duration: 87.034507ms)","trace[842052643] 'applied index is now lower than readState.Index' (duration: 180.767748ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T14:58:15.927912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.04399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4013"} {"level":"info","ts":"2026-02-17T14:58:15.927982Z","caller":"traceutil/trace.go:171","msg":"trace[146037098] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:321; }","duration":"268.141313ms","start":"2026-02-17T14:58:15.659831Z","end":"2026-02-17T14:58:15.927972Z","steps":["trace[146037098] 'agreement among raft nodes before linearized reading' (duration: 267.931978ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:15.928444Z","caller":"traceutil/trace.go:171","msg":"trace[1292714116] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"286.076168ms","start":"2026-02-17T14:58:15.642352Z","end":"2026-02-17T14:58:15.928429Z","steps":["trace[1292714116] 'process raft request' (duration: 104.531782ms)","trace[1292714116] 'compare' (duration: 179.568473ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T14:58:15.928767Z","caller":"traceutil/trace.go:171","msg":"trace[672935729] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"278.336662ms","start":"2026-02-17T14:58:15.650419Z","end":"2026-02-17T14:58:15.928756Z","steps":["trace[672935729] 'process raft request' (duration: 276.776578ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:15.929045Z","caller":"traceutil/trace.go:171","msg":"trace[1101077350] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"278.555867ms","start":"2026-02-17T14:58:15.650479Z","end":"2026-02-17T14:58:15.929035Z","steps":["trace[1101077350] 'process raft request' (duration: 276.815379ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:15.92958Z","caller":"traceutil/trace.go:171","msg":"trace[483773347] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"278.992606ms","start":"2026-02-17T14:58:15.650521Z","end":"2026-02-17T14:58:15.929514Z","steps":["trace[483773347] 'process raft request' (duration: 276.806819ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:15.931314Z","caller":"traceutil/trace.go:171","msg":"trace[1831288953] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"266.520998ms","start":"2026-02-17T14:58:15.664787Z","end":"2026-02-17T14:58:15.931308Z","steps":["trace[1831288953] 'process raft request' (duration: 262.747996ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:15.931477Z","caller":"traceutil/trace.go:171","msg":"trace[1953369175] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"266.60592ms","start":"2026-02-17T14:58:15.664865Z","end":"2026-02-17T14:58:15.931471Z","steps":["trace[1953369175] 'process raft request' (duration: 262.694446ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:15.930898Z","caller":"traceutil/trace.go:171","msg":"trace[1470211472] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"277.789821ms","start":"2026-02-17T14:58:15.653094Z","end":"2026-02-17T14:58:15.930884Z","steps":["trace[1470211472] 'process raft request' (duration: 274.260314ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:15.93164Z","caller":"traceutil/trace.go:171","msg":"trace[1767767347] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"266.724553ms","start":"2026-02-17T14:58:15.664908Z","end":"2026-02-17T14:58:15.931632Z","steps":["trace[1767767347] 'process raft request' (duration: 262.684965ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:15.931933Z","caller":"traceutil/trace.go:171","msg":"trace[1273524154] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"265.756502ms","start":"2026-02-17T14:58:15.666131Z","end":"2026-02-17T14:58:15.931888Z","steps":["trace[1273524154] 'process raft request' (duration: 261.48925ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:15.930935Z","caller":"traceutil/trace.go:171","msg":"trace[858563226] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"271.22403ms","start":"2026-02-17T14:58:15.659703Z","end":"2026-02-17T14:58:15.930927Z","steps":["trace[858563226] 'process raft request' (duration: 267.684083ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:15.930958Z","caller":"traceutil/trace.go:171","msg":"trace[868991965] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"268.301096ms","start":"2026-02-17T14:58:15.662651Z","end":"2026-02-17T14:58:15.930952Z","steps":["trace[868991965] 'process raft request' (duration: 264.76498ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:15.931101Z","caller":"traceutil/trace.go:171","msg":"trace[1470171222] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"268.366528ms","start":"2026-02-17T14:58:15.662728Z","end":"2026-02-17T14:58:15.931094Z","steps":["trace[1470171222] 'process raft request' (duration: 264.712489ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:15.931167Z","caller":"traceutil/trace.go:171","msg":"trace[463523887] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"268.392239ms","start":"2026-02-17T14:58:15.66277Z","end":"2026-02-17T14:58:15.931163Z","steps":["trace[463523887] 'process raft request' (duration: 264.701829ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:15.931189Z","caller":"traceutil/trace.go:171","msg":"trace[562203572] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"266.438436ms","start":"2026-02-17T14:58:15.664745Z","end":"2026-02-17T14:58:15.931183Z","steps":["trace[562203572] 'process raft request' (duration: 262.759536ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:23.825562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.303978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-02-17T14:58:23.825645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.078240084s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T14:58:23.825672Z","caller":"traceutil/trace.go:171","msg":"trace[680589510] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:379; }","duration":"695.446741ms","start":"2026-02-17T14:58:23.130207Z","end":"2026-02-17T14:58:23.825654Z","steps":["trace[680589510] 'range keys from in-memory index tree' (duration: 695.198315ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:23.82571Z","caller":"traceutil/trace.go:171","msg":"trace[1451644162] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:379; }","duration":"1.078302024s","start":"2026-02-17T14:58:22.747374Z","end":"2026-02-17T14:58:23.825676Z","steps":["trace[1451644162] 'range keys from in-memory index tree' (duration: 1.078184293s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:23.82572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:23.130038Z","time spent":"695.669806ms","remote":"127.0.0.1:46384","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-17T14:58:23.825743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:22.747349Z","time spent":"1.078386297s","remote":"127.0.0.1:46124","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-17T14:58:23.825975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.1563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4019"} {"level":"info","ts":"2026-02-17T14:58:23.826006Z","caller":"traceutil/trace.go:171","msg":"trace[674056951] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:379; }","duration":"754.213391ms","start":"2026-02-17T14:58:23.071782Z","end":"2026-02-17T14:58:23.825995Z","steps":["trace[674056951] 'range keys from in-memory index tree' (duration: 754.065988ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:23.826007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.967156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-02-17T14:58:23.826033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:23.071768Z","time spent":"754.259312ms","remote":"127.0.0.1:46302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4042,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-02-17T14:58:23.82606Z","caller":"traceutil/trace.go:171","msg":"trace[757412888] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:379; }","duration":"885.025158ms","start":"2026-02-17T14:58:22.941003Z","end":"2026-02-17T14:58:23.826028Z","steps":["trace[757412888] 'range keys from in-memory index tree' (duration: 884.816233ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:23.826088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:22.940987Z","time spent":"885.094279ms","remote":"127.0.0.1:46384","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-17T14:58:23.826169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.044014ms","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-17T14:58:23.826195Z","caller":"traceutil/trace.go:171","msg":"trace[1040682467] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:379; }","duration":"696.104925ms","start":"2026-02-17T14:58:23.130082Z","end":"2026-02-17T14:58:23.826187Z","steps":["trace[1040682467] 'range keys from in-memory index tree' (duration: 695.987193ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:23.826221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:23.130073Z","time spent":"696.141886ms","remote":"127.0.0.1:46384","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-17T14:58:23.825578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"844.639962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6898"} {"level":"info","ts":"2026-02-17T14:58:23.826482Z","caller":"traceutil/trace.go:171","msg":"trace[1064514840] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:379; }","duration":"845.589331ms","start":"2026-02-17T14:58:22.980882Z","end":"2026-02-17T14:58:23.826471Z","steps":["trace[1064514840] 'range keys from in-memory index tree' (duration: 844.54247ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:23.82683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:22.98087Z","time spent":"845.94788ms","remote":"127.0.0.1:46306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6921,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"info","ts":"2026-02-17T14:58:23.950023Z","caller":"traceutil/trace.go:171","msg":"trace[624060725] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"107.542917ms","start":"2026-02-17T14:58:23.84246Z","end":"2026-02-17T14:58:23.950003Z","steps":["trace[624060725] 'process raft request' (duration: 107.110588ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:23.950578Z","caller":"traceutil/trace.go:171","msg":"trace[1435567575] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"107.722881ms","start":"2026-02-17T14:58:23.842845Z","end":"2026-02-17T14:58:23.950568Z","steps":["trace[1435567575] 'process raft request' (duration: 106.863692ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:23.950794Z","caller":"traceutil/trace.go:171","msg":"trace[1216220104] linearizableReadLoop","detail":"{readStateIndex:395; appliedIndex:393; }","duration":"108.198561ms","start":"2026-02-17T14:58:23.842586Z","end":"2026-02-17T14:58:23.950785Z","steps":["trace[1216220104] 'read index received' (duration: 31.184879ms)","trace[1216220104] 'applied index is now lower than readState.Index' (duration: 77.012842ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T14:58:23.95092Z","caller":"traceutil/trace.go:171","msg":"trace[462436252] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"107.471906ms","start":"2026-02-17T14:58:23.84344Z","end":"2026-02-17T14:58:23.950911Z","steps":["trace[462436252] 'process raft request' (duration: 106.945635ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:23.950994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.389825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T14:58:23.951053Z","caller":"traceutil/trace.go:171","msg":"trace[489269719] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:383; }","duration":"108.474447ms","start":"2026-02-17T14:58:23.842569Z","end":"2026-02-17T14:58:23.951043Z","steps":["trace[489269719] 'agreement among raft nodes before linearized reading' (duration: 108.385695ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:23.950976Z","caller":"traceutil/trace.go:171","msg":"trace[1843261776] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"107.240011ms","start":"2026-02-17T14:58:23.843729Z","end":"2026-02-17T14:58:23.950969Z","steps":["trace[1843261776] 'process raft request' (duration: 106.795212ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:34.137874Z","caller":"traceutil/trace.go:171","msg":"trace[172494223] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"127.960085ms","start":"2026-02-17T14:58:34.009898Z","end":"2026-02-17T14:58:34.137858Z","steps":["trace[172494223] 'process raft request' (duration: 127.871723ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:39.050703Z","caller":"traceutil/trace.go:171","msg":"trace[1539555737] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"189.579797ms","start":"2026-02-17T14:58:38.861103Z","end":"2026-02-17T14:58:39.050683Z","steps":["trace[1539555737] 'process raft request' (duration: 189.385823ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:40.263646Z","caller":"traceutil/trace.go:171","msg":"trace[1048162561] linearizableReadLoop","detail":"{readStateIndex:502; appliedIndex:501; }","duration":"162.435395ms","start":"2026-02-17T14:58:40.101194Z","end":"2026-02-17T14:58:40.263629Z","steps":["trace[1048162561] 'read index received' (duration: 162.242881ms)","trace[1048162561] 'applied index is now lower than readState.Index' (duration: 191.994µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T14:58:40.263917Z","caller":"traceutil/trace.go:171","msg":"trace[2023270890] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"232.005448ms","start":"2026-02-17T14:58:40.031904Z","end":"2026-02-17T14:58:40.26391Z","steps":["trace[2023270890] 'process raft request' (duration: 231.582449ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:40.263994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.692481ms","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-17T14:58:40.264011Z","caller":"traceutil/trace.go:171","msg":"trace[164589444] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:484; }","duration":"162.836244ms","start":"2026-02-17T14:58:40.101169Z","end":"2026-02-17T14:58:40.264005Z","steps":["trace[164589444] 'agreement among raft nodes before linearized reading' (duration: 162.694701ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:40.468253Z","caller":"traceutil/trace.go:171","msg":"trace[111363518] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"198.960419ms","start":"2026-02-17T14:58:40.269269Z","end":"2026-02-17T14:58:40.468229Z","steps":["trace[111363518] 'process raft request' (duration: 121.232481ms)","trace[111363518] 'compare' (duration: 77.096313ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T14:58:40.468582Z","caller":"traceutil/trace.go:171","msg":"trace[1666947161] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"197.474037ms","start":"2026-02-17T14:58:40.271093Z","end":"2026-02-17T14:58:40.468567Z","steps":["trace[1666947161] 'process raft request' (duration: 197.070848ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:58:46.467574Z","caller":"traceutil/trace.go:171","msg":"trace[97985389] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"162.178879ms","start":"2026-02-17T14:58:46.305374Z","end":"2026-02-17T14:58:46.467553Z","steps":["trace[97985389] 'process raft request' (duration: 162.073177ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:47.003739Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991526856110799694,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-17T14:58:47.050312Z","caller":"traceutil/trace.go:171","msg":"trace[1713064513] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"717.073495ms","start":"2026-02-17T14:58:46.333222Z","end":"2026-02-17T14:58:47.050296Z","steps":["trace[1713064513] 'process raft request' (duration: 716.972793ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:47.05042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:46.333195Z","time spent":"717.169747ms","remote":"127.0.0.1:46306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T14:58:47.271637Z","caller":"traceutil/trace.go:171","msg":"trace[1568137677] linearizableReadLoop","detail":"{readStateIndex:521; appliedIndex:520; }","duration":"768.823245ms","start":"2026-02-17T14:58:46.502798Z","end":"2026-02-17T14:58:47.271621Z","steps":["trace[1568137677] 'read index received' (duration: 547.957166ms)","trace[1568137677] 'applied index is now lower than readState.Index' (duration: 220.865459ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T14:58:47.271738Z","caller":"traceutil/trace.go:171","msg":"trace[1505203945] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"508.689663ms","start":"2026-02-17T14:58:46.763042Z","end":"2026-02-17T14:58:47.271732Z","steps":["trace[1505203945] 'process raft request' (duration: 508.475928ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:47.271981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"764.316889ms","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-17T14:58:47.272075Z","caller":"traceutil/trace.go:171","msg":"trace[690580427] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:502; }","duration":"764.429251ms","start":"2026-02-17T14:58:46.507619Z","end":"2026-02-17T14:58:47.272048Z","steps":["trace[690580427] 'agreement among raft nodes before linearized reading' (duration: 764.229906ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:47.272116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:46.507607Z","time spent":"764.498622ms","remote":"127.0.0.1:46384","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-17T14:58:47.272306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"769.505929ms","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-17T14:58:47.27181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:46.763015Z","time spent":"508.739874ms","remote":"127.0.0.1:46384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T14:58:47.272332Z","caller":"traceutil/trace.go:171","msg":"trace[1226057846] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:502; }","duration":"769.56494ms","start":"2026-02-17T14:58:46.502759Z","end":"2026-02-17T14:58:47.272324Z","steps":["trace[1226057846] 'agreement among raft nodes before linearized reading' (duration: 769.489329ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:58:47.272358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:58:46.50274Z","time spent":"769.611741ms","remote":"127.0.0.1:46384","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-17T14:58:47.27255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.829793ms","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-17T14:58:47.272579Z","caller":"traceutil/trace.go:171","msg":"trace[82984537] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:502; }","duration":"175.892265ms","start":"2026-02-17T14:58:47.096679Z","end":"2026-02-17T14:58:47.272571Z","steps":["trace[82984537] 'agreement among raft nodes before linearized reading' (duration: 175.73597ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:59:00.532638Z","caller":"traceutil/trace.go:171","msg":"trace[1723235369] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"126.346941ms","start":"2026-02-17T14:59:00.406274Z","end":"2026-02-17T14:59:00.53262Z","steps":["trace[1723235369] 'process raft request' (duration: 126.178057ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:59:07.173736Z","caller":"traceutil/trace.go:171","msg":"trace[1066935963] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"511.898341ms","start":"2026-02-17T14:59:06.661813Z","end":"2026-02-17T14:59:07.173711Z","steps":["trace[1066935963] 'process raft request' (duration: 511.759979ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:07.173938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:06.661797Z","time spent":"512.022582ms","remote":"127.0.0.1:46384","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-17T14:59:08.225487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.417798ms","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-17T14:59:08.225571Z","caller":"traceutil/trace.go:171","msg":"trace[1858080551] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:692; }","duration":"852.531079ms","start":"2026-02-17T14:59:07.373022Z","end":"2026-02-17T14:59:08.225553Z","steps":["trace[1858080551] 'range keys from in-memory index tree' (duration: 852.284385ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:08.225609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:07.373004Z","time spent":"852.59757ms","remote":"127.0.0.1:46384","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-17T14:59:08.225877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"840.672942ms","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-17T14:59:08.225927Z","caller":"traceutil/trace.go:171","msg":"trace[687811080] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:692; }","duration":"840.747833ms","start":"2026-02-17T14:59:07.385165Z","end":"2026-02-17T14:59:08.225913Z","steps":["trace[687811080] 'range keys from in-memory index tree' (duration: 840.55315ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:08.225966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:07.385149Z","time spent":"840.808614ms","remote":"127.0.0.1:46384","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-17T14:59:08.226351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"823.871016ms","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-17T14:59:08.226387Z","caller":"traceutil/trace.go:171","msg":"trace[1417265905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:692; }","duration":"823.922747ms","start":"2026-02-17T14:59:07.402454Z","end":"2026-02-17T14:59:08.226376Z","steps":["trace[1417265905] 'range keys from in-memory index tree' (duration: 823.780245ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:08.226416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:07.402447Z","time spent":"823.963018ms","remote":"127.0.0.1:46384","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-17T14:59:08.226824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.084165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T14:59:08.226854Z","caller":"traceutil/trace.go:171","msg":"trace[850764024] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:692; }","duration":"478.133525ms","start":"2026-02-17T14:59:07.748711Z","end":"2026-02-17T14:59:08.226845Z","steps":["trace[850764024] 'range keys from in-memory index tree' (duration: 478.023304ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:08.226884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:07.748696Z","time spent":"478.181687ms","remote":"127.0.0.1:46126","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-17T14:59:08.386323Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991526856110800065,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-17T14:59:08.764277Z","caller":"traceutil/trace.go:171","msg":"trace[474309206] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"946.168361ms","start":"2026-02-17T14:59:07.818085Z","end":"2026-02-17T14:59:08.764254Z","steps":["trace[474309206] 'process raft request' (duration: 946.062269ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:08.764424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:07.818064Z","time spent":"946.278002ms","remote":"127.0.0.1:46384","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-17T14:59:09.142408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.87069ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T14:59:09.142602Z","caller":"traceutil/trace.go:171","msg":"trace[696287810] linearizableReadLoop","detail":"{readStateIndex:721; appliedIndex:718; }","duration":"1.256947168s","start":"2026-02-17T14:59:07.88564Z","end":"2026-02-17T14:59:09.142587Z","steps":["trace[696287810] 'read index received' (duration: 879.09805ms)","trace[696287810] 'applied index is now lower than readState.Index' (duration: 377.848198ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T14:59:09.14269Z","caller":"traceutil/trace.go:171","msg":"trace[516157429] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"907.347327ms","start":"2026-02-17T14:59:08.23533Z","end":"2026-02-17T14:59:09.142678Z","steps":["trace[516157429] 'process raft request' (duration: 776.114611ms)","trace[516157429] 'compare' (duration: 130.749558ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T14:59:09.142758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:08.235316Z","time spent":"907.402578ms","remote":"127.0.0.1:46384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T14:59:09.143014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.257360115s","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-17T14:59:09.143052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.659482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T14:59:09.143126Z","caller":"traceutil/trace.go:171","msg":"trace[1735955858] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:696; }","duration":"907.742463ms","start":"2026-02-17T14:59:08.235372Z","end":"2026-02-17T14:59:09.143114Z","steps":["trace[1735955858] 'agreement among raft nodes before linearized reading' (duration: 907.649352ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:59:09.143126Z","caller":"traceutil/trace.go:171","msg":"trace[1920258193] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:696; }","duration":"1.257461047s","start":"2026-02-17T14:59:07.885601Z","end":"2026-02-17T14:59:09.143062Z","steps":["trace[1920258193] 'agreement among raft nodes before linearized reading' (duration: 1.257275844s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:09.143156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:08.235368Z","time spent":"907.782144ms","remote":"127.0.0.1:46124","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-17T14:59:09.143174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:07.885587Z","time spent":"1.257575169s","remote":"127.0.0.1:46384","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-17T14:59:09.143384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.40814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.141\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-17T14:59:09.143407Z","caller":"traceutil/trace.go:171","msg":"trace[34421388] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"907.992278ms","start":"2026-02-17T14:59:08.235403Z","end":"2026-02-17T14:59:09.143395Z","steps":["trace[34421388] 'process raft request' (duration: 907.097073ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:59:09.143415Z","caller":"traceutil/trace.go:171","msg":"trace[160332465] range","detail":"{range_begin:/registry/masterleases/199.204.45.141; range_end:; response_count:1; response_revision:696; }","duration":"782.469822ms","start":"2026-02-17T14:59:08.360936Z","end":"2026-02-17T14:59:09.143406Z","steps":["trace[160332465] 'agreement among raft nodes before linearized reading' (duration: 782.36583ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:09.143441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:08.360915Z","time spent":"782.521102ms","remote":"127.0.0.1:46156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.141\" "} {"level":"warn","ts":"2026-02-17T14:59:09.143537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:08.235399Z","time spent":"908.036708ms","remote":"127.0.0.1:46384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T14:59:09.143693Z","caller":"traceutil/trace.go:171","msg":"trace[568184773] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"907.944356ms","start":"2026-02-17T14:59:08.235735Z","end":"2026-02-17T14:59:09.14368Z","steps":["trace[568184773] 'process raft request' (duration: 906.812708ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:09.143746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:08.23573Z","time spent":"907.986697ms","remote":"127.0.0.1:46384","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-17T14:59:09.393346Z","caller":"traceutil/trace.go:171","msg":"trace[1838935825] linearizableReadLoop","detail":"{readStateIndex:723; appliedIndex:721; }","duration":"239.082343ms","start":"2026-02-17T14:59:09.154247Z","end":"2026-02-17T14:59:09.393329Z","steps":["trace[1838935825] 'read index received' (duration: 223.298773ms)","trace[1838935825] 'applied index is now lower than readState.Index' (duration: 15.7826ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T14:59:09.393568Z","caller":"traceutil/trace.go:171","msg":"trace[24605607] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"243.098387ms","start":"2026-02-17T14:59:09.150459Z","end":"2026-02-17T14:59:09.393558Z","steps":["trace[24605607] 'process raft request' (duration: 241.766966ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:09.393717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.454159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T14:59:09.393747Z","caller":"traceutil/trace.go:171","msg":"trace[312757335] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:697; }","duration":"239.50865ms","start":"2026-02-17T14:59:09.154229Z","end":"2026-02-17T14:59:09.393738Z","steps":["trace[312757335] 'agreement among raft nodes before linearized reading' (duration: 239.452609ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:09.393921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.718453ms","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-17T14:59:09.393945Z","caller":"traceutil/trace.go:171","msg":"trace[408985166] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:697; }","duration":"215.761094ms","start":"2026-02-17T14:59:09.178177Z","end":"2026-02-17T14:59:09.393938Z","steps":["trace[408985166] 'agreement among raft nodes before linearized reading' (duration: 215.675122ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:59:27.617241Z","caller":"traceutil/trace.go:171","msg":"trace[526394269] linearizableReadLoop","detail":"{readStateIndex:779; appliedIndex:778; }","duration":"383.470778ms","start":"2026-02-17T14:59:27.233753Z","end":"2026-02-17T14:59:27.617224Z","steps":["trace[526394269] 'read index received' (duration: 383.325695ms)","trace[526394269] 'applied index is now lower than readState.Index' (duration: 144.443µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T14:59:27.617479Z","caller":"traceutil/trace.go:171","msg":"trace[1200153686] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"401.724066ms","start":"2026-02-17T14:59:27.215748Z","end":"2026-02-17T14:59:27.617472Z","steps":["trace[1200153686] 'process raft request' (duration: 401.375711ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:27.617544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:27.215726Z","time spent":"401.768057ms","remote":"127.0.0.1:46384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T14:59:27.617685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.931706ms","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-17T14:59:27.6177Z","caller":"traceutil/trace.go:171","msg":"trace[168749729] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:750; }","duration":"383.971167ms","start":"2026-02-17T14:59:27.233724Z","end":"2026-02-17T14:59:27.617695Z","steps":["trace[168749729] 'agreement among raft nodes before linearized reading' (duration: 383.904956ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:27.617714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:27.23371Z","time spent":"384.000637ms","remote":"127.0.0.1:46384","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-17T14:59:27.617799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.943755ms","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-17T14:59:27.617811Z","caller":"traceutil/trace.go:171","msg":"trace[1186817295] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:750; }","duration":"383.980597ms","start":"2026-02-17T14:59:27.233826Z","end":"2026-02-17T14:59:27.617807Z","steps":["trace[1186817295] 'agreement among raft nodes before linearized reading' (duration: 383.946466ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:27.617822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:27.233813Z","time spent":"384.006627ms","remote":"127.0.0.1:46384","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-17T14:59:27.617932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.701889ms","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-17T14:59:27.617947Z","caller":"traceutil/trace.go:171","msg":"trace[75087729] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:750; }","duration":"130.733449ms","start":"2026-02-17T14:59:27.48721Z","end":"2026-02-17T14:59:27.617943Z","steps":["trace[75087729] 'agreement among raft nodes before linearized reading' (duration: 130.681968ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:27.618029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.960117ms","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-17T14:59:27.618041Z","caller":"traceutil/trace.go:171","msg":"trace[58641649] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:750; }","duration":"137.002698ms","start":"2026-02-17T14:59:27.481035Z","end":"2026-02-17T14:59:27.618037Z","steps":["trace[58641649] 'agreement among raft nodes before linearized reading' (duration: 136.968348ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:27.618099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.129539ms","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-17T14:59:27.618111Z","caller":"traceutil/trace.go:171","msg":"trace[1419315631] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:750; }","duration":"281.18616ms","start":"2026-02-17T14:59:27.336922Z","end":"2026-02-17T14:59:27.618108Z","steps":["trace[1419315631] 'agreement among raft nodes before linearized reading' (duration: 281.16254ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:59:27.78718Z","caller":"traceutil/trace.go:171","msg":"trace[703936069] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"165.60573ms","start":"2026-02-17T14:59:27.621554Z","end":"2026-02-17T14:59:27.78716Z","steps":["trace[703936069] 'process raft request' (duration: 165.450977ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:59:27.802317Z","caller":"traceutil/trace.go:171","msg":"trace[648669565] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"178.970691ms","start":"2026-02-17T14:59:27.623332Z","end":"2026-02-17T14:59:27.802303Z","steps":["trace[648669565] 'process raft request' (duration: 178.801848ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:59:27.802531Z","caller":"traceutil/trace.go:171","msg":"trace[1258692761] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"178.153018ms","start":"2026-02-17T14:59:27.624361Z","end":"2026-02-17T14:59:27.802514Z","steps":["trace[1258692761] 'process raft request' (duration: 177.882494ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:59:27.802617Z","caller":"traceutil/trace.go:171","msg":"trace[1803244145] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"178.235911ms","start":"2026-02-17T14:59:27.624374Z","end":"2026-02-17T14:59:27.80261Z","steps":["trace[1803244145] 'process raft request' (duration: 177.897184ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:29.316823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.997758ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T14:59:29.316904Z","caller":"traceutil/trace.go:171","msg":"trace[893048224] linearizableReadLoop","detail":"{readStateIndex:785; appliedIndex:784; }","duration":"579.463709ms","start":"2026-02-17T14:59:28.737426Z","end":"2026-02-17T14:59:29.31689Z","steps":["trace[893048224] 'read index received' (duration: 186.267038ms)","trace[893048224] 'applied index is now lower than readState.Index' (duration: 393.195691ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T14:59:29.316961Z","caller":"traceutil/trace.go:171","msg":"trace[1491189761] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"711.521609ms","start":"2026-02-17T14:59:28.605432Z","end":"2026-02-17T14:59:29.316954Z","steps":["trace[1491189761] 'process raft request' (duration: 318.330568ms)","trace[1491189761] 'compare' (duration: 392.895776ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T14:59:29.317006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:28.605414Z","time spent":"711.568379ms","remote":"127.0.0.1:46156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T14:59:29.31732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.914065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T14:59:29.317344Z","caller":"traceutil/trace.go:171","msg":"trace[832666307] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:755; }","duration":"579.984757ms","start":"2026-02-17T14:59:28.737352Z","end":"2026-02-17T14:59:29.317337Z","steps":["trace[832666307] 'agreement among raft nodes before linearized reading' (duration: 579.919866ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:29.317368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:28.737325Z","time spent":"580.034718ms","remote":"127.0.0.1:46380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"warn","ts":"2026-02-17T14:59:29.317642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.825479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T14:59:29.317665Z","caller":"traceutil/trace.go:171","msg":"trace[733651454] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:755; }","duration":"482.888491ms","start":"2026-02-17T14:59:28.83477Z","end":"2026-02-17T14:59:29.317658Z","steps":["trace[733651454] 'agreement among raft nodes before linearized reading' (duration: 482.83848ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:29.317689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:28.83475Z","time spent":"482.932881ms","remote":"127.0.0.1:46176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":11,"response size":30,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-02-17T14:59:29.317847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.990728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T14:59:29.317867Z","caller":"traceutil/trace.go:171","msg":"trace[1796641444] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:755; }","duration":"309.011379ms","start":"2026-02-17T14:59:29.008849Z","end":"2026-02-17T14:59:29.317861Z","steps":["trace[1796641444] 'agreement among raft nodes before linearized reading' (duration: 308.979968ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:29.317883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:29.008789Z","time spent":"309.08956ms","remote":"127.0.0.1:46442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-02-17T14:59:29.63202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.231413ms","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-17T14:59:29.632077Z","caller":"traceutil/trace.go:171","msg":"trace[782858409] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:756; }","duration":"163.333765ms","start":"2026-02-17T14:59:29.468731Z","end":"2026-02-17T14:59:29.632064Z","steps":["trace[782858409] 'count revisions from in-memory index tree' (duration: 163.153582ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:59:29.826979Z","caller":"traceutil/trace.go:171","msg":"trace[2124875097] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"190.955882ms","start":"2026-02-17T14:59:29.636004Z","end":"2026-02-17T14:59:29.82696Z","steps":["trace[2124875097] 'process raft request' (duration: 190.650847ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:42.500144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.596127ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T14:59:42.500253Z","caller":"traceutil/trace.go:171","msg":"trace[1002389087] linearizableReadLoop","detail":"{readStateIndex:878; appliedIndex:875; }","duration":"518.487531ms","start":"2026-02-17T14:59:41.981756Z","end":"2026-02-17T14:59:42.500244Z","steps":["trace[1002389087] 'read index received' (duration: 60.060317ms)","trace[1002389087] 'applied index is now lower than readState.Index' (duration: 458.426694ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T14:59:42.50038Z","caller":"traceutil/trace.go:171","msg":"trace[1420325394] transaction","detail":"{read_only:false; response_revision:843; number_of_response:1; }","duration":"521.622921ms","start":"2026-02-17T14:59:41.97875Z","end":"2026-02-17T14:59:42.500373Z","steps":["trace[1420325394] 'process raft request' (duration: 371.750298ms)","trace[1420325394] 'compare' (duration: 149.317861ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T14:59:42.50041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:41.978737Z","time spent":"521.657741ms","remote":"127.0.0.1:46384","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-17T14:59:42.500478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.676075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-02-17T14:59:42.500515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.601031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T14:59:42.500531Z","caller":"traceutil/trace.go:171","msg":"trace[2044531149] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:845; }","duration":"493.701733ms","start":"2026-02-17T14:59:42.006824Z","end":"2026-02-17T14:59:42.500526Z","steps":["trace[2044531149] 'agreement among raft nodes before linearized reading' (duration: 493.673062ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:42.500545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:42.006815Z","time spent":"493.726303ms","remote":"127.0.0.1:46520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":30,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"info","ts":"2026-02-17T14:59:42.500559Z","caller":"traceutil/trace.go:171","msg":"trace[784888919] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:845; }","duration":"518.771847ms","start":"2026-02-17T14:59:41.981753Z","end":"2026-02-17T14:59:42.500525Z","steps":["trace[784888919] 'agreement among raft nodes before linearized reading' (duration: 518.633444ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:42.500594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:41.981734Z","time spent":"518.852509ms","remote":"127.0.0.1:46400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":4,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-02-17T14:59:42.500667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.672716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T14:59:42.500682Z","caller":"traceutil/trace.go:171","msg":"trace[461910502] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:845; }","duration":"162.748047ms","start":"2026-02-17T14:59:42.337929Z","end":"2026-02-17T14:59:42.500677Z","steps":["trace[461910502] 'agreement among raft nodes before linearized reading' (duration: 162.724377ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:59:42.500804Z","caller":"traceutil/trace.go:171","msg":"trace[1785604745] transaction","detail":"{read_only:false; response_revision:844; number_of_response:1; }","duration":"519.35349ms","start":"2026-02-17T14:59:41.981438Z","end":"2026-02-17T14:59:42.500792Z","steps":["trace[1785604745] 'process raft request' (duration: 518.760407ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:42.50089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:41.98143Z","time spent":"519.39489ms","remote":"127.0.0.1:46384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T14:59:42.500905Z","caller":"traceutil/trace.go:171","msg":"trace[937796283] transaction","detail":"{read_only:false; response_revision:845; number_of_response:1; }","duration":"516.232211ms","start":"2026-02-17T14:59:41.984668Z","end":"2026-02-17T14:59:42.5009Z","steps":["trace[937796283] 'process raft request' (duration: 515.556066ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:42.500935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:41.984661Z","time spent":"516.257801ms","remote":"127.0.0.1:46384","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-17T14:59:43.505244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.518985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T14:59:43.505291Z","caller":"traceutil/trace.go:171","msg":"trace[137060249] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:845; }","duration":"757.597347ms","start":"2026-02-17T14:59:42.747683Z","end":"2026-02-17T14:59:43.50528Z","steps":["trace[137060249] 'range keys from in-memory index tree' (duration: 757.440704ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:43.505311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:42.747669Z","time spent":"757.638568ms","remote":"127.0.0.1:46126","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-17T14:59:52.24832Z","caller":"traceutil/trace.go:171","msg":"trace[433571847] transaction","detail":"{read_only:false; response_revision:870; number_of_response:1; }","duration":"109.299376ms","start":"2026-02-17T14:59:52.139005Z","end":"2026-02-17T14:59:52.248304Z","steps":["trace[433571847] 'process raft request' (duration: 109.211464ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:58.777667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.73319ms","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-17T14:59:58.77775Z","caller":"traceutil/trace.go:171","msg":"trace[290928680] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:887; }","duration":"111.856652ms","start":"2026-02-17T14:59:58.665875Z","end":"2026-02-17T14:59:58.777732Z","steps":["trace[290928680] 'range keys from in-memory index tree' (duration: 111.553506ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:58.778337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.13956ms","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-17T14:59:58.778574Z","caller":"traceutil/trace.go:171","msg":"trace[1144150370] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:887; }","duration":"122.374885ms","start":"2026-02-17T14:59:58.656143Z","end":"2026-02-17T14:59:58.778518Z","steps":["trace[1144150370] 'range keys from in-memory index tree' (duration: 122.014178ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:59:58.996202Z","caller":"traceutil/trace.go:171","msg":"trace[2012389687] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"209.086173ms","start":"2026-02-17T14:59:58.787099Z","end":"2026-02-17T14:59:58.996185Z","steps":["trace[2012389687] 'process raft request' (duration: 208.97454ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T14:59:59.344617Z","caller":"traceutil/trace.go:171","msg":"trace[101441946] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"556.586393ms","start":"2026-02-17T14:59:58.788013Z","end":"2026-02-17T14:59:59.344599Z","steps":["trace[101441946] 'process raft request' (duration: 556.547962ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:59.344715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:58.787966Z","time spent":"556.699235ms","remote":"127.0.0.1:46384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T14:59:59.344923Z","caller":"traceutil/trace.go:171","msg":"trace[579262169] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"557.049693ms","start":"2026-02-17T14:59:58.787866Z","end":"2026-02-17T14:59:59.344916Z","steps":["trace[579262169] 'process raft request' (duration: 550.035078ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T14:59:59.344958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T14:59:58.787282Z","time spent":"557.657396ms","remote":"127.0.0.1:46384","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-17T15:00:01.224225Z","caller":"traceutil/trace.go:171","msg":"trace[1072754199] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"220.478604ms","start":"2026-02-17T15:00:01.003707Z","end":"2026-02-17T15:00:01.224186Z","steps":["trace[1072754199] 'process raft request' (duration: 220.29756ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:00:16.863795Z","caller":"traceutil/trace.go:171","msg":"trace[1278233344] linearizableReadLoop","detail":"{readStateIndex:1043; appliedIndex:1042; }","duration":"422.578739ms","start":"2026-02-17T15:00:16.441192Z","end":"2026-02-17T15:00:16.863771Z","steps":["trace[1278233344] 'read index received' (duration: 422.465497ms)","trace[1278233344] 'applied index is now lower than readState.Index' (duration: 112.062µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T15:00:16.86394Z","caller":"traceutil/trace.go:171","msg":"trace[1242385730] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"531.496786ms","start":"2026-02-17T15:00:16.332432Z","end":"2026-02-17T15:00:16.863929Z","steps":["trace[1242385730] 'process raft request' (duration: 531.195279ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:00:16.864038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:00:16.332404Z","time spent":"531.562098ms","remote":"127.0.0.1:46384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T15:00:16.864146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.8723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-02-17T15:00:16.864218Z","caller":"traceutil/trace.go:171","msg":"trace[198213739] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1002; }","duration":"251.982823ms","start":"2026-02-17T15:00:16.612215Z","end":"2026-02-17T15:00:16.864198Z","steps":["trace[198213739] 'agreement among raft nodes before linearized reading' (duration: 251.791979ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:00:16.864391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.201063ms","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-17T15:00:16.864418Z","caller":"traceutil/trace.go:171","msg":"trace[404132205] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1002; }","duration":"423.257923ms","start":"2026-02-17T15:00:16.441152Z","end":"2026-02-17T15:00:16.86441Z","steps":["trace[404132205] 'agreement among raft nodes before linearized reading' (duration: 423.176492ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T15:00:16.864449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T15:00:16.441136Z","time spent":"423.302445ms","remote":"127.0.0.1:46384","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-17T15:00:16.972075Z","caller":"traceutil/trace.go:171","msg":"trace[433517925] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"102.537705ms","start":"2026-02-17T15:00:16.869519Z","end":"2026-02-17T15:00:16.972057Z","steps":["trace[433517925] 'process raft request' (duration: 102.432173ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:00:16.979093Z","caller":"traceutil/trace.go:171","msg":"trace[802734370] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"109.179213ms","start":"2026-02-17T15:00:16.869879Z","end":"2026-02-17T15:00:16.979058Z","steps":["trace[802734370] 'process raft request' (duration: 109.121261ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:03:12.501103Z","caller":"traceutil/trace.go:171","msg":"trace[2129975425] linearizableReadLoop","detail":"{readStateIndex:1823; appliedIndex:1822; }","duration":"233.488644ms","start":"2026-02-17T15:03:12.267594Z","end":"2026-02-17T15:03:12.501083Z","steps":["trace[2129975425] 'read index received' (duration: 233.279979ms)","trace[2129975425] 'applied index is now lower than readState.Index' (duration: 207.765µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T15:03:12.501316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.699389ms","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-17T15:03:12.501351Z","caller":"traceutil/trace.go:171","msg":"trace[1228681536] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1746; }","duration":"233.797692ms","start":"2026-02-17T15:03:12.267541Z","end":"2026-02-17T15:03:12.501339Z","steps":["trace[1228681536] 'agreement among raft nodes before linearized reading' (duration: 233.630758ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T15:03:12.50141Z","caller":"traceutil/trace.go:171","msg":"trace[111374017] transaction","detail":"{read_only:false; response_revision:1746; number_of_response:1; }","duration":"272.471924ms","start":"2026-02-17T15:03:12.228908Z","end":"2026-02-17T15:03:12.50138Z","steps":["trace[111374017] 'process raft request' (duration: 272.023035ms)"],"step_count":1}