{"level":"warn","ts":"2026-02-13T06:57:39.217978Z","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-13T06:57:39.218085Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.235: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.235:2380","--initial-cluster=instance=https://199.204.45.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.235: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-13T06:57:39.218161Z","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-13T06:57:39.218174Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-02-13T06:57:39.218192Z","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-13T06:57:39.218971Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"]} {"level":"info","ts":"2026-02-13T06:57:39.219063Z","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.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.235: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-13T06:57:39.224Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.688046ms"} {"level":"info","ts":"2026-02-13T06:57:39.239494Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"aab6040abcf11","cluster-id":"2bae7d3d8857c059"} {"level":"info","ts":"2026-02-13T06:57:39.239556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=()"} {"level":"info","ts":"2026-02-13T06:57:39.239574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 0"} {"level":"info","ts":"2026-02-13T06:57:39.239583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft aab6040abcf11 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-13T06:57:39.239591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 1"} {"level":"info","ts":"2026-02-13T06:57:39.239618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"warn","ts":"2026-02-13T06:57:39.251074Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-13T06:57:39.252534Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-13T06:57:39.254043Z","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-13T06:57:39.256241Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"aab6040abcf11","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-13T06:57:39.258286Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"aab6040abcf11","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-13T06:57:39.258454Z","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-13T06:57:39.258529Z","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-13T06:57:39.258593Z","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-13T06:57:39.259608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"info","ts":"2026-02-13T06:57:39.259792Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","added-peer-id":"aab6040abcf11","added-peer-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-02-13T06:57:39.271615Z","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-13T06:57:39.272086Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"aab6040abcf11","initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-13T06:57:39.272426Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-13T06:57:39.271929Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-02-13T06:57:39.273007Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-02-13T06:57:40.040849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 is starting a new election at term 1"} {"level":"info","ts":"2026-02-13T06:57:40.040915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-13T06:57:40.040933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgPreVoteResp from aab6040abcf11 at term 1"} {"level":"info","ts":"2026-02-13T06:57:40.040946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became candidate at term 2"} {"level":"info","ts":"2026-02-13T06:57:40.040952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgVoteResp from aab6040abcf11 at term 2"} {"level":"info","ts":"2026-02-13T06:57:40.040961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became leader at term 2"} {"level":"info","ts":"2026-02-13T06:57:40.04097Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: aab6040abcf11 elected leader aab6040abcf11 at term 2"} {"level":"info","ts":"2026-02-13T06:57:40.045287Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"aab6040abcf11","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.235:2379]}","request-path":"/0/members/aab6040abcf11/attributes","cluster-id":"2bae7d3d8857c059","publish-timeout":"7s"} {"level":"info","ts":"2026-02-13T06:57:40.04531Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-13T06:57:40.045562Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T06:57:40.045624Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-13T06:57:40.048163Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-13T06:57:40.051079Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.235:2379"} {"level":"info","ts":"2026-02-13T06:57:40.051797Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T06:57:40.053023Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T06:57:40.05314Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T06:57:40.061297Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-13T06:57:40.061312Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-13T06:57:57.232125Z","caller":"traceutil/trace.go:171","msg":"trace[1574209101] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"447.193146ms","start":"2026-02-13T06:57:56.784912Z","end":"2026-02-13T06:57:57.232105Z","steps":["trace[1574209101] 'process raft request' (duration: 447.088073ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:57.232681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:56.78489Z","time spent":"447.31832ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:58:00.143493Z","caller":"traceutil/trace.go:171","msg":"trace[1026893763] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"159.220194ms","start":"2026-02-13T06:57:59.984245Z","end":"2026-02-13T06:58:00.143465Z","steps":["trace[1026893763] 'process raft request' (duration: 98.454353ms)","trace[1026893763] 'compare' (duration: 60.606247ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T06:58:00.166838Z","caller":"traceutil/trace.go:171","msg":"trace[372825008] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"181.580414ms","start":"2026-02-13T06:57:59.985239Z","end":"2026-02-13T06:58:00.166819Z","steps":["trace[372825008] 'process raft request' (duration: 181.481202ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:58:03.106752Z","caller":"traceutil/trace.go:171","msg":"trace[2115941327] linearizableReadLoop","detail":"{readStateIndex:438; appliedIndex:437; }","duration":"455.723147ms","start":"2026-02-13T06:58:02.651007Z","end":"2026-02-13T06:58:03.10673Z","steps":["trace[2115941327] 'read index received' (duration: 444.32913ms)","trace[2115941327] 'applied index is now lower than readState.Index' (duration: 11.392977ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:58:03.106886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.84611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:58:03.106923Z","caller":"traceutil/trace.go:171","msg":"trace[783844908] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:423; }","duration":"455.949652ms","start":"2026-02-13T06:58:02.650965Z","end":"2026-02-13T06:58:03.106915Z","steps":["trace[783844908] 'agreement among raft nodes before linearized reading' (duration: 455.84528ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:03.106955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:02.650943Z","time spent":"456.003163ms","remote":"127.0.0.1:52758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-13T06:58:03.10718Z","caller":"traceutil/trace.go:171","msg":"trace[1733353503] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"804.461239ms","start":"2026-02-13T06:58:02.302706Z","end":"2026-02-13T06:58:03.107167Z","steps":["trace[1733353503] 'process raft request' (duration: 792.57963ms)","trace[1733353503] 'compare' (duration: 10.626936ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:58:03.107255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:02.302689Z","time spent":"804.517131ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:58:05.547018Z","caller":"traceutil/trace.go:171","msg":"trace[1095262621] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"282.424622ms","start":"2026-02-13T06:58:05.264578Z","end":"2026-02-13T06:58:05.547003Z","steps":["trace[1095262621] 'process raft request' (duration: 282.297929ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:58:05.554138Z","caller":"traceutil/trace.go:171","msg":"trace[2008176842] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"239.296184ms","start":"2026-02-13T06:58:05.314818Z","end":"2026-02-13T06:58:05.554114Z","steps":["trace[2008176842] 'process raft request' (duration: 239.165791ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:12.091014Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920878932738419494,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-13T06:58:12.110324Z","caller":"traceutil/trace.go:171","msg":"trace[1976549172] linearizableReadLoop","detail":"{readStateIndex:494; appliedIndex:493; }","duration":"519.794566ms","start":"2026-02-13T06:58:11.590507Z","end":"2026-02-13T06:58:12.110302Z","steps":["trace[1976549172] 'read index received' (duration: 519.58423ms)","trace[1976549172] 'applied index is now lower than readState.Index' (duration: 209.546µs)"],"step_count":2} {"level":"info","ts":"2026-02-13T06:58:12.110429Z","caller":"traceutil/trace.go:171","msg":"trace[894899472] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"816.678676ms","start":"2026-02-13T06:58:11.29374Z","end":"2026-02-13T06:58:12.110419Z","steps":["trace[894899472] 'process raft request' (duration: 816.385858ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:12.110547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:11.293722Z","time spent":"816.734377ms","remote":"127.0.0.1:52942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4254,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T06:58:12.110713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.957955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:58:12.110777Z","caller":"traceutil/trace.go:171","msg":"trace[1054270591] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:477; }","duration":"461.028357ms","start":"2026-02-13T06:58:11.649732Z","end":"2026-02-13T06:58:12.11076Z","steps":["trace[1054270591] 'agreement among raft nodes before linearized reading' (duration: 460.929214ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:12.110815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:11.649642Z","time spent":"461.165741ms","remote":"127.0.0.1:52758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-13T06:58:12.111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.183436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-13T06:58:12.111027Z","caller":"traceutil/trace.go:171","msg":"trace[1706864378] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:477; }","duration":"155.244378ms","start":"2026-02-13T06:58:11.955774Z","end":"2026-02-13T06:58:12.111018Z","steps":["trace[1706864378] 'agreement among raft nodes before linearized reading' (duration: 155.193637ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:12.111028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.513165ms","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-13T06:58:12.11107Z","caller":"traceutil/trace.go:171","msg":"trace[1822159232] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:477; }","duration":"520.580266ms","start":"2026-02-13T06:58:11.590477Z","end":"2026-02-13T06:58:12.111057Z","steps":["trace[1822159232] 'agreement among raft nodes before linearized reading' (duration: 520.437832ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:12.1111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:11.590448Z","time spent":"520.645218ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-13T06:58:14.046991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.747149ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T06:58:14.04717Z","caller":"traceutil/trace.go:171","msg":"trace[1262158067] linearizableReadLoop","detail":"{readStateIndex:501; appliedIndex:499; }","duration":"391.350696ms","start":"2026-02-13T06:58:13.655805Z","end":"2026-02-13T06:58:14.047156Z","steps":["trace[1262158067] 'read index received' (duration: 206.192946ms)","trace[1262158067] 'applied index is now lower than readState.Index' (duration: 185.15677ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:58:14.047258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.458598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:58:14.04729Z","caller":"traceutil/trace.go:171","msg":"trace[1960061669] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:483; }","duration":"391.52452ms","start":"2026-02-13T06:58:13.655756Z","end":"2026-02-13T06:58:14.04728Z","steps":["trace[1960061669] 'agreement among raft nodes before linearized reading' (duration: 391.452728ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:14.047327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:13.655731Z","time spent":"391.589342ms","remote":"127.0.0.1:52768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-13T06:58:14.04768Z","caller":"traceutil/trace.go:171","msg":"trace[499390485] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"586.170255ms","start":"2026-02-13T06:58:13.461495Z","end":"2026-02-13T06:58:14.047665Z","steps":["trace[499390485] 'process raft request' (duration: 400.560474ms)","trace[499390485] 'compare' (duration: 184.602574ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:58:14.047747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:13.461476Z","time spent":"586.238688ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:58:14.047883Z","caller":"traceutil/trace.go:171","msg":"trace[2026133914] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"445.866929ms","start":"2026-02-13T06:58:13.602005Z","end":"2026-02-13T06:58:14.047872Z","steps":["trace[2026133914] 'process raft request' (duration: 445.090378ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:14.047938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:13.601981Z","time spent":"445.929681ms","remote":"127.0.0.1:52788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:58:15.818635Z","caller":"traceutil/trace.go:171","msg":"trace[2124595495] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"146.108223ms","start":"2026-02-13T06:58:15.672512Z","end":"2026-02-13T06:58:15.818621Z","steps":["trace[2124595495] 'process raft request' (duration: 146.011001ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:20.392721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.612291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-13T06:58:20.39284Z","caller":"traceutil/trace.go:171","msg":"trace[843599110] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:499; }","duration":"100.757445ms","start":"2026-02-13T06:58:20.292036Z","end":"2026-02-13T06:58:20.392794Z","steps":["trace[843599110] 'range keys from in-memory index tree' (duration: 100.491677ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:20.393057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.873137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-s98zd\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-13T06:58:20.393089Z","caller":"traceutil/trace.go:171","msg":"trace[1395572763] range","detail":"{range_begin:/registry/pods/kube-system/cilium-s98zd; range_end:; response_count:1; response_revision:499; }","duration":"284.96384ms","start":"2026-02-13T06:58:20.108115Z","end":"2026-02-13T06:58:20.393078Z","steps":["trace[1395572763] 'range keys from in-memory index tree' (duration: 284.689463ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:58:20.508078Z","caller":"traceutil/trace.go:171","msg":"trace[11885191] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"100.744345ms","start":"2026-02-13T06:58:20.407312Z","end":"2026-02-13T06:58:20.508056Z","steps":["trace[11885191] 'process raft request' (duration: 100.54301ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:21.15247Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920878932738419558,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-13T06:58:21.580596Z","caller":"traceutil/trace.go:171","msg":"trace[50260781] linearizableReadLoop","detail":"{readStateIndex:523; appliedIndex:519; }","duration":"928.576199ms","start":"2026-02-13T06:58:20.652004Z","end":"2026-02-13T06:58:21.58058Z","steps":["trace[50260781] 'read index received' (duration: 928.357353ms)","trace[50260781] 'applied index is now lower than readState.Index' (duration: 218.266µs)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:58:21.580703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"928.677212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:58:21.58073Z","caller":"traceutil/trace.go:171","msg":"trace[1913770816] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:504; }","duration":"928.753564ms","start":"2026-02-13T06:58:20.651969Z","end":"2026-02-13T06:58:21.580723Z","steps":["trace[1913770816] 'agreement among raft nodes before linearized reading' (duration: 928.674792ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:21.580756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:20.651955Z","time spent":"928.795965ms","remote":"127.0.0.1:52758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-13T06:58:21.581587Z","caller":"traceutil/trace.go:171","msg":"trace[845701273] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"1.17408314s","start":"2026-02-13T06:58:20.407492Z","end":"2026-02-13T06:58:21.581575Z","steps":["trace[845701273] 'process raft request' (duration: 1.172923069s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:21.581681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:20.407484Z","time spent":"1.174134271s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:58:21.582211Z","caller":"traceutil/trace.go:171","msg":"trace[122477547] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"1.17109629s","start":"2026-02-13T06:58:20.411106Z","end":"2026-02-13T06:58:21.582202Z","steps":["trace[122477547] 'process raft request' (duration: 1.169398254s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:21.582295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:20.411007Z","time spent":"1.171263785s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:58:21.582519Z","caller":"traceutil/trace.go:171","msg":"trace[1039027949] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"1.170813362s","start":"2026-02-13T06:58:20.411695Z","end":"2026-02-13T06:58:21.582509Z","steps":["trace[1039027949] 'process raft request' (duration: 1.168830659s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:21.582587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:20.41169Z","time spent":"1.170853263s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:58:21.582983Z","caller":"traceutil/trace.go:171","msg":"trace[1964891461] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"1.165991342s","start":"2026-02-13T06:58:20.416983Z","end":"2026-02-13T06:58:21.582975Z","steps":["trace[1964891461] 'process raft request' (duration: 1.163562117s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:21.583054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:20.416974Z","time spent":"1.166033743s","remote":"127.0.0.1:52958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T06:58:23.742118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.157304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.235\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-13T06:58:23.742197Z","caller":"traceutil/trace.go:171","msg":"trace[425109272] range","detail":"{range_begin:/registry/masterleases/199.204.45.235; range_end:; response_count:1; response_revision:515; }","duration":"387.271207ms","start":"2026-02-13T06:58:23.354905Z","end":"2026-02-13T06:58:23.742177Z","steps":["trace[425109272] 'range keys from in-memory index tree' (duration: 387.0088ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:23.742262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:23.35489Z","time spent":"387.337679ms","remote":"127.0.0.1:52788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.235\" "} {"level":"warn","ts":"2026-02-13T06:58:23.742488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.941461ms","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-13T06:58:23.742526Z","caller":"traceutil/trace.go:171","msg":"trace[1536014706] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:515; }","duration":"144.992263ms","start":"2026-02-13T06:58:23.597525Z","end":"2026-02-13T06:58:23.742517Z","steps":["trace[1536014706] 'range keys from in-memory index tree' (duration: 144.858979ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:23.742734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.130817ms","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-13T06:58:23.742834Z","caller":"traceutil/trace.go:171","msg":"trace[1176512286] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:515; }","duration":"145.476295ms","start":"2026-02-13T06:58:23.597343Z","end":"2026-02-13T06:58:23.742819Z","steps":["trace[1176512286] 'range keys from in-memory index tree' (duration: 144.831669ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:23.744139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.228377ms","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-13T06:58:23.744209Z","caller":"traceutil/trace.go:171","msg":"trace[161175551] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:515; }","duration":"323.32268ms","start":"2026-02-13T06:58:23.420877Z","end":"2026-02-13T06:58:23.7442Z","steps":["trace[161175551] 'range keys from in-memory index tree' (duration: 323.121815ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:23.744248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:23.420863Z","time spent":"323.377471ms","remote":"127.0.0.1:52866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":372,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-02-13T06:58:23.745233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.759527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-13T06:58:23.750112Z","caller":"traceutil/trace.go:171","msg":"trace[2018556130] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:515; }","duration":"152.648799ms","start":"2026-02-13T06:58:23.59745Z","end":"2026-02-13T06:58:23.750099Z","steps":["trace[2018556130] 'range keys from in-memory index tree' (duration: 147.675764ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:58:35.886364Z","caller":"traceutil/trace.go:171","msg":"trace[982215467] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"172.664125ms","start":"2026-02-13T06:58:35.713681Z","end":"2026-02-13T06:58:35.886345Z","steps":["trace[982215467] 'process raft request' (duration: 172.152571ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:36.759364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.706939ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T06:58:36.759459Z","caller":"traceutil/trace.go:171","msg":"trace[574075473] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"864.051868ms","start":"2026-02-13T06:58:35.895396Z","end":"2026-02-13T06:58:36.759448Z","steps":["trace[574075473] 'process raft request' (duration: 349.202295ms)","trace[574075473] 'compare' (duration: 514.546115ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:58:36.759502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:35.895382Z","time spent":"864.104419ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T06:58:37.358418Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.088215476s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-13T06:58:37.681946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.352471ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T06:58:37.682801Z","caller":"traceutil/trace.go:171","msg":"trace[1734938324] linearizableReadLoop","detail":"{readStateIndex:694; appliedIndex:690; }","duration":"1.768944912s","start":"2026-02-13T06:58:35.913845Z","end":"2026-02-13T06:58:37.68279Z","steps":["trace[1734938324] 'read index received' (duration: 330.73844ms)","trace[1734938324] 'applied index is now lower than readState.Index' (duration: 1.438205772s)"],"step_count":2} {"level":"info","ts":"2026-02-13T06:58:37.682854Z","caller":"traceutil/trace.go:171","msg":"trace[65644793] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"1.780343578s","start":"2026-02-13T06:58:35.902504Z","end":"2026-02-13T06:58:37.682847Z","steps":["trace[65644793] 'process raft request' (duration: 1.456040951s)","trace[65644793] 'compare' (duration: 323.166296ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:58:37.682894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:35.902496Z","time spent":"1.780373958s","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14311,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:58:37.683094Z","caller":"traceutil/trace.go:171","msg":"trace[273957582] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"1.778856348s","start":"2026-02-13T06:58:35.904231Z","end":"2026-02-13T06:58:37.683087Z","steps":["trace[273957582] 'process raft request' (duration: 1.777775749s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:37.683131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:35.904225Z","time spent":"1.778885919s","remote":"127.0.0.1:52942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4129,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:58:37.683264Z","caller":"traceutil/trace.go:171","msg":"trace[1882355566] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"1.777406779s","start":"2026-02-13T06:58:35.90585Z","end":"2026-02-13T06:58:37.683257Z","steps":["trace[1882355566] 'process raft request' (duration: 1.776891185s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:37.683294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:35.905831Z","time spent":"1.77744611s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:58:37.683367Z","caller":"traceutil/trace.go:171","msg":"trace[995392740] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"1.474068325s","start":"2026-02-13T06:58:36.209294Z","end":"2026-02-13T06:58:37.683362Z","steps":["trace[995392740] 'process raft request' (duration: 1.473468859s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:37.683396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:36.209272Z","time spent":"1.474108536s","remote":"127.0.0.1:52824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":723,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-13T06:58:37.683603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.769752674s","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-13T06:58:37.683626Z","caller":"traceutil/trace.go:171","msg":"trace[209782806] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:672; }","duration":"1.769807144s","start":"2026-02-13T06:58:35.913812Z","end":"2026-02-13T06:58:37.683619Z","steps":["trace[209782806] 'agreement among raft nodes before linearized reading' (duration: 1.769726702s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:37.683644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:35.913803Z","time spent":"1.769837336s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-13T06:58:38.402863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.056187ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T06:58:38.402927Z","caller":"traceutil/trace.go:171","msg":"trace[517726098] linearizableReadLoop","detail":"{readStateIndex:696; appliedIndex:695; }","duration":"720.088142ms","start":"2026-02-13T06:58:37.682829Z","end":"2026-02-13T06:58:38.402917Z","steps":["trace[517726098] 'read index received' (duration: 391.927332ms)","trace[517726098] 'applied index is now lower than readState.Index' (duration: 328.16009ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:58:38.403036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.471424181s","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-13T06:58:38.403051Z","caller":"traceutil/trace.go:171","msg":"trace[301772716] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:673; }","duration":"2.471470653s","start":"2026-02-13T06:58:35.931576Z","end":"2026-02-13T06:58:38.403047Z","steps":["trace[301772716] 'agreement among raft nodes before linearized reading' (duration: 2.47136575s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:38.403069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:35.931568Z","time spent":"2.471496823s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-13T06:58:38.403083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.587004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:58:38.403137Z","caller":"traceutil/trace.go:171","msg":"trace[1992861859] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:673; }","duration":"749.691467ms","start":"2026-02-13T06:58:37.653433Z","end":"2026-02-13T06:58:38.403124Z","steps":["trace[1992861859] 'agreement among raft nodes before linearized reading' (duration: 749.585794ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:38.403159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:37.653421Z","time spent":"749.734149ms","remote":"127.0.0.1:52758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-13T06:58:38.403265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.8336719s","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-13T06:58:38.403286Z","caller":"traceutil/trace.go:171","msg":"trace[562120260] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:673; }","duration":"1.83371253s","start":"2026-02-13T06:58:36.569566Z","end":"2026-02-13T06:58:38.403279Z","steps":["trace[562120260] 'agreement among raft nodes before linearized reading' (duration: 1.833664349s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:38.403301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:36.569553Z","time spent":"1.833744422s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-13T06:58:38.403352Z","caller":"traceutil/trace.go:171","msg":"trace[1065411644] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"2.145997265s","start":"2026-02-13T06:58:36.257347Z","end":"2026-02-13T06:58:38.403344Z","steps":["trace[1065411644] 'process raft request' (duration: 1.817400313s)","trace[1065411644] 'compare' (duration: 327.971415ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:58:38.403397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.193909471s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-7kst9\" ","response":"range_response_count:1 size:4818"} {"level":"info","ts":"2026-02-13T06:58:38.403411Z","caller":"traceutil/trace.go:171","msg":"trace[1334245911] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-7kst9; range_end:; response_count:1; response_revision:673; }","duration":"2.193948481s","start":"2026-02-13T06:58:36.209459Z","end":"2026-02-13T06:58:38.403407Z","steps":["trace[1334245911] 'agreement among raft nodes before linearized reading' (duration: 2.1939098s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:38.403412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:36.257328Z","time spent":"2.146042445s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T06:58:38.403423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:36.209449Z","time spent":"2.193971773s","remote":"127.0.0.1:52958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":4839,"request content":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-7kst9\" "} {"level":"info","ts":"2026-02-13T06:58:38.615487Z","caller":"traceutil/trace.go:171","msg":"trace[490035546] linearizableReadLoop","detail":"{readStateIndex:698; appliedIndex:696; }","duration":"208.697243ms","start":"2026-02-13T06:58:38.406734Z","end":"2026-02-13T06:58:38.615431Z","steps":["trace[490035546] 'read index received' (duration: 197.568524ms)","trace[490035546] 'applied index is now lower than readState.Index' (duration: 11.127839ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:58:38.61561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.843707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:58:38.61564Z","caller":"traceutil/trace.go:171","msg":"trace[226300932] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:675; }","duration":"208.900378ms","start":"2026-02-13T06:58:38.406731Z","end":"2026-02-13T06:58:38.615631Z","steps":["trace[226300932] 'agreement among raft nodes before linearized reading' (duration: 208.811386ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:58:38.615931Z","caller":"traceutil/trace.go:171","msg":"trace[1220774697] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"918.325554ms","start":"2026-02-13T06:58:37.697593Z","end":"2026-02-13T06:58:38.615919Z","steps":["trace[1220774697] 'process raft request' (duration: 906.701002ms)","trace[1220774697] 'compare' (duration: 10.683387ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:58:38.616009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:37.697579Z","time spent":"918.378496ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:58:38.616774Z","caller":"traceutil/trace.go:171","msg":"trace[444825827] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"916.836314ms","start":"2026-02-13T06:58:37.6999Z","end":"2026-02-13T06:58:38.616736Z","steps":["trace[444825827] 'process raft request' (duration: 915.478337ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:38.616839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:37.699894Z","time spent":"916.910717ms","remote":"127.0.0.1:52942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4481,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:58:38.710089Z","caller":"traceutil/trace.go:171","msg":"trace[1385869426] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"301.447174ms","start":"2026-02-13T06:58:38.408629Z","end":"2026-02-13T06:58:38.710076Z","steps":["trace[1385869426] 'process raft request' (duration: 301.414163ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:38.710182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:38.408621Z","time spent":"301.511225ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:58:38.710452Z","caller":"traceutil/trace.go:171","msg":"trace[1664632809] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"303.663033ms","start":"2026-02-13T06:58:38.406781Z","end":"2026-02-13T06:58:38.710444Z","steps":["trace[1664632809] 'process raft request' (duration: 303.18215ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:38.710493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:38.406772Z","time spent":"303.697633ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:58:42.183172Z","caller":"traceutil/trace.go:171","msg":"trace[2010363539] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"475.349112ms","start":"2026-02-13T06:58:41.707796Z","end":"2026-02-13T06:58:42.183145Z","steps":["trace[2010363539] 'process raft request' (duration: 475.202738ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:42.183329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:41.707784Z","time spent":"475.465015ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:58:46.977667Z","caller":"traceutil/trace.go:171","msg":"trace[169634311] linearizableReadLoop","detail":"{readStateIndex:729; appliedIndex:728; }","duration":"326.810684ms","start":"2026-02-13T06:58:46.650808Z","end":"2026-02-13T06:58:46.977619Z","steps":["trace[169634311] 'read index received' (duration: 326.68559ms)","trace[169634311] 'applied index is now lower than readState.Index' (duration: 124.554µs)"],"step_count":2} {"level":"info","ts":"2026-02-13T06:58:46.977858Z","caller":"traceutil/trace.go:171","msg":"trace[2004257051] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"606.305118ms","start":"2026-02-13T06:58:46.371547Z","end":"2026-02-13T06:58:46.977853Z","steps":["trace[2004257051] 'process raft request' (duration: 605.982779ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:46.977937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:46.371531Z","time spent":"606.347419ms","remote":"127.0.0.1:52942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4769,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T06:58:46.978051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.242975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:58:46.978072Z","caller":"traceutil/trace.go:171","msg":"trace[151350903] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:703; }","duration":"327.297987ms","start":"2026-02-13T06:58:46.650769Z","end":"2026-02-13T06:58:46.978067Z","steps":["trace[151350903] 'agreement among raft nodes before linearized reading' (duration: 327.265336ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:46.978085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:46.650751Z","time spent":"327.331878ms","remote":"127.0.0.1:52758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-13T06:58:46.978208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.735752ms","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-13T06:58:46.978225Z","caller":"traceutil/trace.go:171","msg":"trace[1251718295] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:703; }","duration":"294.784404ms","start":"2026-02-13T06:58:46.683436Z","end":"2026-02-13T06:58:46.978221Z","steps":["trace[1251718295] 'agreement among raft nodes before linearized reading' (duration: 294.722032ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:46.978397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.678005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-13T06:58:46.978415Z","caller":"traceutil/trace.go:171","msg":"trace[1419536122] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:703; }","duration":"188.731667ms","start":"2026-02-13T06:58:46.789679Z","end":"2026-02-13T06:58:46.978411Z","steps":["trace[1419536122] 'agreement among raft nodes before linearized reading' (duration: 188.687576ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:46.978516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.585922ms","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-13T06:58:46.978529Z","caller":"traceutil/trace.go:171","msg":"trace[799151216] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:703; }","duration":"236.621463ms","start":"2026-02-13T06:58:46.741904Z","end":"2026-02-13T06:58:46.978525Z","steps":["trace[799151216] 'agreement among raft nodes before linearized reading' (duration: 236.572572ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:46.978609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.231086ms","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-13T06:58:46.978621Z","caller":"traceutil/trace.go:171","msg":"trace[682417137] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:703; }","duration":"241.277297ms","start":"2026-02-13T06:58:46.73734Z","end":"2026-02-13T06:58:46.978617Z","steps":["trace[682417137] 'agreement among raft nodes before linearized reading' (duration: 241.241416ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:47.400257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.477655ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T06:58:47.400386Z","caller":"traceutil/trace.go:171","msg":"trace[219233837] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"410.47006ms","start":"2026-02-13T06:58:46.989906Z","end":"2026-02-13T06:58:47.400376Z","steps":["trace[219233837] 'process raft request' (duration: 410.45097ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:47.400433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:46.989897Z","time spent":"410.506751ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:58:47.40059Z","caller":"traceutil/trace.go:171","msg":"trace[1700409958] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"414.57847ms","start":"2026-02-13T06:58:46.986006Z","end":"2026-02-13T06:58:47.400585Z","steps":["trace[1700409958] 'process raft request' (duration: 106.730215ms)","trace[1700409958] 'compare' (duration: 307.420033ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:58:47.400616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:46.985995Z","time spent":"414.607241ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:58:47.400669Z","caller":"traceutil/trace.go:171","msg":"trace[286672932] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"414.492928ms","start":"2026-02-13T06:58:46.986173Z","end":"2026-02-13T06:58:47.400666Z","steps":["trace[286672932] 'process raft request' (duration: 414.140089ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:47.40069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:46.986167Z","time spent":"414.511298ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:58:47.400739Z","caller":"traceutil/trace.go:171","msg":"trace[1238072942] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"414.399256ms","start":"2026-02-13T06:58:46.986336Z","end":"2026-02-13T06:58:47.400735Z","steps":["trace[1238072942] 'process raft request' (duration: 414.007225ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:58:47.400759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:58:46.986311Z","time spent":"414.436936ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:58:59.673661Z","caller":"traceutil/trace.go:171","msg":"trace[968106856] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"124.99353ms","start":"2026-02-13T06:58:59.54865Z","end":"2026-02-13T06:58:59.673643Z","steps":["trace[968106856] 'process raft request' (duration: 41.205167ms)","trace[968106856] 'compare' (duration: 83.351891ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T06:58:59.673776Z","caller":"traceutil/trace.go:171","msg":"trace[492741971] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"110.1188ms","start":"2026-02-13T06:58:59.563651Z","end":"2026-02-13T06:58:59.673769Z","steps":["trace[492741971] 'process raft request' (duration: 109.73416ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:59:01.714446Z","caller":"traceutil/trace.go:171","msg":"trace[419979451] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"108.860247ms","start":"2026-02-13T06:59:01.605564Z","end":"2026-02-13T06:59:01.714424Z","steps":["trace[419979451] 'process raft request' (duration: 108.475886ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:59:04.036808Z","caller":"traceutil/trace.go:171","msg":"trace[1620099146] linearizableReadLoop","detail":"{readStateIndex:780; appliedIndex:779; }","duration":"312.262514ms","start":"2026-02-13T06:59:03.724524Z","end":"2026-02-13T06:59:04.036786Z","steps":["trace[1620099146] 'read index received' (duration: 312.074969ms)","trace[1620099146] 'applied index is now lower than readState.Index' (duration: 186.715µs)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:59:04.037199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.645054ms","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-13T06:59:04.037271Z","caller":"traceutil/trace.go:171","msg":"trace[13650372] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:750; }","duration":"312.743186ms","start":"2026-02-13T06:59:03.724509Z","end":"2026-02-13T06:59:04.037252Z","steps":["trace[13650372] 'agreement among raft nodes before linearized reading' (duration: 312.49926ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:04.03729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.081656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-13T06:59:04.037314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:03.724503Z","time spent":"312.803318ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-13T06:59:04.037332Z","caller":"traceutil/trace.go:171","msg":"trace[1979442662] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:750; }","duration":"310.158517ms","start":"2026-02-13T06:59:03.727161Z","end":"2026-02-13T06:59:04.03732Z","steps":["trace[1979442662] 'agreement among raft nodes before linearized reading' (duration: 309.999713ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:04.037367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:03.727155Z","time spent":"310.204268ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-13T06:59:04.037481Z","caller":"traceutil/trace.go:171","msg":"trace[261476990] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"315.466149ms","start":"2026-02-13T06:59:03.722004Z","end":"2026-02-13T06:59:04.03747Z","steps":["trace[261476990] 'process raft request' (duration: 314.654347ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:04.03755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:03.721993Z","time spent":"315.508211ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:59:04.218313Z","caller":"traceutil/trace.go:171","msg":"trace[77743600] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"174.954922ms","start":"2026-02-13T06:59:04.043334Z","end":"2026-02-13T06:59:04.218289Z","steps":["trace[77743600] 'process raft request' (duration: 174.725275ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:04.599858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.468323ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T06:59:04.599943Z","caller":"traceutil/trace.go:171","msg":"trace[102474489] linearizableReadLoop","detail":"{readStateIndex:782; appliedIndex:781; }","duration":"322.601951ms","start":"2026-02-13T06:59:04.277326Z","end":"2026-02-13T06:59:04.599928Z","steps":["trace[102474489] 'read index received' (duration: 135.921843ms)","trace[102474489] 'applied index is now lower than readState.Index' (duration: 186.679148ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:59:04.600061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.731955ms","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-13T06:59:04.600085Z","caller":"traceutil/trace.go:171","msg":"trace[1345377618] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:752; }","duration":"322.816327ms","start":"2026-02-13T06:59:04.277261Z","end":"2026-02-13T06:59:04.600077Z","steps":["trace[1345377618] 'agreement among raft nodes before linearized reading' (duration: 322.707735ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:04.600117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:04.277242Z","time spent":"322.868798ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-13T06:59:04.600159Z","caller":"traceutil/trace.go:171","msg":"trace[2042704843] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"556.423576ms","start":"2026-02-13T06:59:04.043707Z","end":"2026-02-13T06:59:04.60013Z","steps":["trace[2042704843] 'process raft request' (duration: 369.591023ms)","trace[2042704843] 'compare' (duration: 186.386011ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:59:04.600285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:04.043699Z","time spent":"556.517308ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:59:05.481495Z","caller":"traceutil/trace.go:171","msg":"trace[1304449726] linearizableReadLoop","detail":"{readStateIndex:784; appliedIndex:783; }","duration":"127.418015ms","start":"2026-02-13T06:59:05.354056Z","end":"2026-02-13T06:59:05.481474Z","steps":["trace[1304449726] 'read index received' (duration: 127.22434ms)","trace[1304449726] 'applied index is now lower than readState.Index' (duration: 192.425µs)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:59:05.481652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.56897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:59:05.481684Z","caller":"traceutil/trace.go:171","msg":"trace[140611574] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:754; }","duration":"127.656351ms","start":"2026-02-13T06:59:05.354019Z","end":"2026-02-13T06:59:05.481675Z","steps":["trace[140611574] 'agreement among raft nodes before linearized reading' (duration: 127.552328ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:59:05.481832Z","caller":"traceutil/trace.go:171","msg":"trace[316659335] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"172.544068ms","start":"2026-02-13T06:59:05.309267Z","end":"2026-02-13T06:59:05.481811Z","steps":["trace[316659335] 'process raft request' (duration: 172.069125ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:06.291117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.666899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-13T06:59:06.291178Z","caller":"traceutil/trace.go:171","msg":"trace[1170417855] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:754; }","duration":"676.741251ms","start":"2026-02-13T06:59:05.614425Z","end":"2026-02-13T06:59:06.291166Z","steps":["trace[1170417855] 'range keys from in-memory index tree' (duration: 676.563936ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:06.291196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:05.614374Z","time spent":"676.817693ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-13T06:59:06.291275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.646453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:59:06.291299Z","caller":"traceutil/trace.go:171","msg":"trace[1837679642] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:754; }","duration":"585.699364ms","start":"2026-02-13T06:59:05.705595Z","end":"2026-02-13T06:59:06.291294Z","steps":["trace[1837679642] 'count revisions from in-memory index tree' (duration: 585.608082ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:06.291317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:05.705582Z","time spent":"585.730644ms","remote":"127.0.0.1:53290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":26,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:59:06.291601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.711486ms","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-13T06:59:06.29162Z","caller":"traceutil/trace.go:171","msg":"trace[1217335991] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:754; }","duration":"248.766487ms","start":"2026-02-13T06:59:06.04285Z","end":"2026-02-13T06:59:06.291616Z","steps":["trace[1217335991] 'range keys from in-memory index tree' (duration: 248.596572ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:59:06.639005Z","caller":"traceutil/trace.go:171","msg":"trace[1190448448] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"340.836662ms","start":"2026-02-13T06:59:06.298145Z","end":"2026-02-13T06:59:06.638981Z","steps":["trace[1190448448] 'process raft request' (duration: 339.810604ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:06.639132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:06.298127Z","time spent":"340.938215ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:59:06.639216Z","caller":"traceutil/trace.go:171","msg":"trace[485928686] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"339.046784ms","start":"2026-02-13T06:59:06.30016Z","end":"2026-02-13T06:59:06.639207Z","steps":["trace[485928686] 'process raft request' (duration: 337.884133ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:06.63926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:06.300153Z","time spent":"339.081775ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:59:06.759887Z","caller":"traceutil/trace.go:171","msg":"trace[98500358] linearizableReadLoop","detail":"{readStateIndex:789; appliedIndex:787; }","duration":"110.186972ms","start":"2026-02-13T06:59:06.649686Z","end":"2026-02-13T06:59:06.759873Z","steps":["trace[98500358] 'read index received' (duration: 106.917854ms)","trace[98500358] 'applied index is now lower than readState.Index' (duration: 3.268598ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:59:06.760189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.48957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:59:06.760275Z","caller":"traceutil/trace.go:171","msg":"trace[1631230706] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:759; }","duration":"110.592813ms","start":"2026-02-13T06:59:06.649674Z","end":"2026-02-13T06:59:06.760267Z","steps":["trace[1631230706] 'agreement among raft nodes before linearized reading' (duration: 110.432149ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:59:06.760605Z","caller":"traceutil/trace.go:171","msg":"trace[1061663097] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"114.084977ms","start":"2026-02-13T06:59:06.646511Z","end":"2026-02-13T06:59:06.760596Z","steps":["trace[1061663097] 'process raft request' (duration: 110.084589ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:59:06.761179Z","caller":"traceutil/trace.go:171","msg":"trace[1794513189] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"113.779118ms","start":"2026-02-13T06:59:06.647391Z","end":"2026-02-13T06:59:06.76117Z","steps":["trace[1794513189] 'process raft request' (duration: 112.458103ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:59:18.897828Z","caller":"traceutil/trace.go:171","msg":"trace[792742820] linearizableReadLoop","detail":"{readStateIndex:878; appliedIndex:877; }","duration":"492.045846ms","start":"2026-02-13T06:59:18.405737Z","end":"2026-02-13T06:59:18.897782Z","steps":["trace[792742820] 'read index received' (duration: 489.252762ms)","trace[792742820] 'applied index is now lower than readState.Index' (duration: 2.792064ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:59:18.898048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.841684ms","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-13T06:59:18.898112Z","caller":"traceutil/trace.go:171","msg":"trace[807784365] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:843; }","duration":"397.950137ms","start":"2026-02-13T06:59:18.500145Z","end":"2026-02-13T06:59:18.898095Z","steps":["trace[807784365] 'agreement among raft nodes before linearized reading' (duration: 397.829244ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:18.89815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:18.500132Z","time spent":"398.008389ms","remote":"127.0.0.1:52994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":26,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:59:18.898171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.988249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-13T06:59:18.898209Z","caller":"traceutil/trace.go:171","msg":"trace[49219134] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:843; }","duration":"154.02895ms","start":"2026-02-13T06:59:18.744158Z","end":"2026-02-13T06:59:18.898187Z","steps":["trace[49219134] 'agreement among raft nodes before linearized reading' (duration: 153.959298ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:18.898468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.930184ms","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-13T06:59:18.898493Z","caller":"traceutil/trace.go:171","msg":"trace[1541646876] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:843; }","duration":"167.984345ms","start":"2026-02-13T06:59:18.730502Z","end":"2026-02-13T06:59:18.898486Z","steps":["trace[1541646876] 'agreement among raft nodes before linearized reading' (duration: 167.872972ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:18.898612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.813322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:59:18.898629Z","caller":"traceutil/trace.go:171","msg":"trace[601412649] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:843; }","duration":"247.862593ms","start":"2026-02-13T06:59:18.650761Z","end":"2026-02-13T06:59:18.898623Z","steps":["trace[601412649] 'agreement among raft nodes before linearized reading' (duration: 247.835062ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:18.898069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.301073ms","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-13T06:59:18.89874Z","caller":"traceutil/trace.go:171","msg":"trace[2145132690] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:843; }","duration":"493.032813ms","start":"2026-02-13T06:59:18.4057Z","end":"2026-02-13T06:59:18.898733Z","steps":["trace[2145132690] 'agreement among raft nodes before linearized reading' (duration: 492.232061ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:18.898767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:18.405684Z","time spent":"493.073315ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-13T06:59:19.706015Z","caller":"traceutil/trace.go:171","msg":"trace[1331265402] transaction","detail":"{read_only:false; response_revision:849; number_of_response:1; }","duration":"149.130149ms","start":"2026-02-13T06:59:19.556871Z","end":"2026-02-13T06:59:19.706001Z","steps":["trace[1331265402] 'process raft request' (duration: 148.834671ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:21.423309Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920878932738420318,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-13T06:59:21.786588Z","caller":"traceutil/trace.go:171","msg":"trace[975284455] transaction","detail":"{read_only:false; response_revision:850; number_of_response:1; }","duration":"865.170966ms","start":"2026-02-13T06:59:20.921402Z","end":"2026-02-13T06:59:21.786573Z","steps":["trace[975284455] 'process raft request' (duration: 865.085094ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:21.786681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:20.921394Z","time spent":"865.238318ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T06:59:23.667396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.018012624s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-13T06:59:23.667461Z","caller":"traceutil/trace.go:171","msg":"trace[2018086865] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.018116546s","start":"2026-02-13T06:59:21.649332Z","end":"2026-02-13T06:59:23.667448Z","steps":["trace[2018086865] 'agreement among raft nodes before linearized reading' (duration: 2.018038654s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:23.667502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:21.649315Z","time spent":"2.018181409s","remote":"127.0.0.1:52758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/13 06:59:23 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:59:23.992559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.092508486s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T06:59:23.992719Z","caller":"traceutil/trace.go:171","msg":"trace[963700070] linearizableReadLoop","detail":"{readStateIndex:887; appliedIndex:885; }","duration":"3.070489246s","start":"2026-02-13T06:59:20.922217Z","end":"2026-02-13T06:59:23.992706Z","steps":["trace[963700070] 'read index received' (duration: 864.728314ms)","trace[963700070] 'applied index is now lower than readState.Index' (duration: 2.205760322s)"],"step_count":2} {"level":"info","ts":"2026-02-13T06:59:23.992893Z","caller":"traceutil/trace.go:171","msg":"trace[1835726874] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"3.068236715s","start":"2026-02-13T06:59:20.924648Z","end":"2026-02-13T06:59:23.992885Z","steps":["trace[1835726874] 'process raft request' (duration: 975.318858ms)","trace[1835726874] 'compare' (duration: 2.091770937s)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:59:23.992935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:20.92464Z","time spent":"3.068273036s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:59:23.993051Z","caller":"traceutil/trace.go:171","msg":"trace[1735303737] transaction","detail":"{read_only:false; response_revision:852; number_of_response:1; }","duration":"3.068173834s","start":"2026-02-13T06:59:20.924872Z","end":"2026-02-13T06:59:23.993046Z","steps":["trace[1735303737] 'process raft request' (duration: 3.067757603s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:23.993087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:20.924854Z","time spent":"3.068214464s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T06:59:23.993224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.071002689s","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-13T06:59:23.993243Z","caller":"traceutil/trace.go:171","msg":"trace[249280536] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:852; }","duration":"3.07103253s","start":"2026-02-13T06:59:20.922204Z","end":"2026-02-13T06:59:23.993237Z","steps":["trace[249280536] 'agreement among raft nodes before linearized reading' (duration: 3.070956108s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:23.993262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:20.922199Z","time spent":"3.071058431s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-13T06:59:23.993377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.070537617s","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-13T06:59:23.993394Z","caller":"traceutil/trace.go:171","msg":"trace[1839263407] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:852; }","duration":"3.070565498s","start":"2026-02-13T06:59:20.922823Z","end":"2026-02-13T06:59:23.993389Z","steps":["trace[1839263407] 'agreement among raft nodes before linearized reading' (duration: 3.070515147s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:23.993411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:20.922817Z","time spent":"3.070588838s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-13T06:59:23.995038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.778951749s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:59:23.995089Z","caller":"traceutil/trace.go:171","msg":"trace[743928749] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:852; }","duration":"2.77901919s","start":"2026-02-13T06:59:21.216058Z","end":"2026-02-13T06:59:23.995078Z","steps":["trace[743928749] 'agreement among raft nodes before linearized reading' (duration: 2.778926338s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:23.995114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:21.21602Z","time spent":"2.779087592s","remote":"127.0.0.1:53154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":26,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:59:23.995258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.589869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-13T06:59:23.995272Z","caller":"traceutil/trace.go:171","msg":"trace[1734286836] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:852; }","duration":"108.60436ms","start":"2026-02-13T06:59:23.886663Z","end":"2026-02-13T06:59:23.995268Z","steps":["trace[1734286836] 'agreement among raft nodes before linearized reading' (duration: 108.560798ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:23.995393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.532735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-13T06:59:23.995408Z","caller":"traceutil/trace.go:171","msg":"trace[1189569020] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:852; }","duration":"205.567726ms","start":"2026-02-13T06:59:23.789834Z","end":"2026-02-13T06:59:23.995402Z","steps":["trace[1189569020] 'agreement among raft nodes before linearized reading' (duration: 205.504604ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:23.99541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.928394656s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:59:23.995437Z","caller":"traceutil/trace.go:171","msg":"trace[112295210] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:852; }","duration":"2.928426187s","start":"2026-02-13T06:59:21.067004Z","end":"2026-02-13T06:59:23.99543Z","steps":["trace[112295210] 'agreement among raft nodes before linearized reading' (duration: 2.928376436s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:23.995458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:21.066967Z","time spent":"2.928484888s","remote":"127.0.0.1:52908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":26,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:59:23.995476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.855993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:59:23.99549Z","caller":"traceutil/trace.go:171","msg":"trace[1056511533] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:852; }","duration":"327.890874ms","start":"2026-02-13T06:59:23.667594Z","end":"2026-02-13T06:59:23.995485Z","steps":["trace[1056511533] 'agreement among raft nodes before linearized reading' (duration: 327.869714ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:23.995502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:23.667584Z","time spent":"327.915445ms","remote":"127.0.0.1:52768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-13T06:59:23.995605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.453132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.235\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-13T06:59:23.995617Z","caller":"traceutil/trace.go:171","msg":"trace[1177379377] range","detail":"{range_begin:/registry/masterleases/199.204.45.235; range_end:; response_count:1; response_revision:852; }","duration":"635.498803ms","start":"2026-02-13T06:59:23.360115Z","end":"2026-02-13T06:59:23.995614Z","steps":["trace[1177379377] 'agreement among raft nodes before linearized reading' (duration: 635.458482ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:23.995628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:23.360097Z","time spent":"635.528933ms","remote":"127.0.0.1:52788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.235\" "} {"level":"warn","ts":"2026-02-13T06:59:23.995702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"846.534835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:59:23.995714Z","caller":"traceutil/trace.go:171","msg":"trace[1953714706] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:852; }","duration":"846.563276ms","start":"2026-02-13T06:59:23.149146Z","end":"2026-02-13T06:59:23.99571Z","steps":["trace[1953714706] 'agreement among raft nodes before linearized reading' (duration: 846.545496ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:23.995726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:23.149097Z","time spent":"846.625368ms","remote":"127.0.0.1:52758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-13T06:59:23.9958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.076575109s","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-13T06:59:23.995814Z","caller":"traceutil/trace.go:171","msg":"trace[1880985956] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:852; }","duration":"2.07664396s","start":"2026-02-13T06:59:21.919166Z","end":"2026-02-13T06:59:23.99581Z","steps":["trace[1880985956] 'agreement among raft nodes before linearized reading' (duration: 2.076619189s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:23.995829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:21.919149Z","time spent":"2.076676572s","remote":"127.0.0.1:53008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":26,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:59:23.995914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.413055484s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-13T06:59:23.995926Z","caller":"traceutil/trace.go:171","msg":"trace[431041140] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:852; }","duration":"2.413106685s","start":"2026-02-13T06:59:21.582816Z","end":"2026-02-13T06:59:23.995922Z","steps":["trace[431041140] 'agreement among raft nodes before linearized reading' (duration: 2.413069464s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:23.995939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:21.582795Z","time spent":"2.413140186s","remote":"127.0.0.1:52972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":42,"response size":28,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"info","ts":"2026-02-13T06:59:30.462561Z","caller":"traceutil/trace.go:171","msg":"trace[1082400753] linearizableReadLoop","detail":"{readStateIndex:907; appliedIndex:906; }","duration":"425.620552ms","start":"2026-02-13T06:59:30.036919Z","end":"2026-02-13T06:59:30.462539Z","steps":["trace[1082400753] 'read index received' (duration: 425.437077ms)","trace[1082400753] 'applied index is now lower than readState.Index' (duration: 182.304µs)"],"step_count":2} {"level":"info","ts":"2026-02-13T06:59:30.462851Z","caller":"traceutil/trace.go:171","msg":"trace[1624821886] transaction","detail":"{read_only:false; response_revision:870; number_of_response:1; }","duration":"435.383784ms","start":"2026-02-13T06:59:30.027456Z","end":"2026-02-13T06:59:30.46284Z","steps":["trace[1624821886] 'process raft request' (duration: 434.957532ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:30.462957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:30.027439Z","time spent":"435.440415ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T06:59:30.463199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.274769ms","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-13T06:59:30.463243Z","caller":"traceutil/trace.go:171","msg":"trace[820701587] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:870; }","duration":"426.31824ms","start":"2026-02-13T06:59:30.036902Z","end":"2026-02-13T06:59:30.46322Z","steps":["trace[820701587] 'agreement among raft nodes before linearized reading' (duration: 426.215307ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:30.463271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:30.036895Z","time spent":"426.370041ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-13T06:59:30.46355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.434912ms","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-13T06:59:30.463623Z","caller":"traceutil/trace.go:171","msg":"trace[1292583308] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:870; }","duration":"420.544794ms","start":"2026-02-13T06:59:30.04306Z","end":"2026-02-13T06:59:30.463605Z","steps":["trace[1292583308] 'agreement among raft nodes before linearized reading' (duration: 420.319368ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:30.463654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.294069ms","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":"warn","ts":"2026-02-13T06:59:30.463664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:30.043047Z","time spent":"420.609576ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-13T06:59:30.463687Z","caller":"traceutil/trace.go:171","msg":"trace[1626415654] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:870; }","duration":"317.359451ms","start":"2026-02-13T06:59:30.146319Z","end":"2026-02-13T06:59:30.463678Z","steps":["trace[1626415654] 'agreement among raft nodes before linearized reading' (duration: 317.300849ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:30.463716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:30.146305Z","time spent":"317.403782ms","remote":"127.0.0.1:53232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":26,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:59:30.463874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.966912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-13T06:59:30.463901Z","caller":"traceutil/trace.go:171","msg":"trace[800507061] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:870; }","duration":"105.021493ms","start":"2026-02-13T06:59:30.358872Z","end":"2026-02-13T06:59:30.463893Z","steps":["trace[800507061] 'agreement among raft nodes before linearized reading' (duration: 104.976192ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:30.463924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.919801ms","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-13T06:59:30.463957Z","caller":"traceutil/trace.go:171","msg":"trace[1438653378] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:870; }","duration":"405.957672ms","start":"2026-02-13T06:59:30.057987Z","end":"2026-02-13T06:59:30.463945Z","steps":["trace[1438653378] 'agreement among raft nodes before linearized reading' (duration: 405.87634ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:30.463984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:30.057982Z","time spent":"405.996373ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-13T06:59:30.4642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.529134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-13T06:59:30.464227Z","caller":"traceutil/trace.go:171","msg":"trace[336533728] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:870; }","duration":"420.566125ms","start":"2026-02-13T06:59:30.043653Z","end":"2026-02-13T06:59:30.464219Z","steps":["trace[336533728] 'agreement among raft nodes before linearized reading' (duration: 420.488512ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:30.464256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:30.043645Z","time spent":"420.604866ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-13T06:59:30.717394Z","caller":"traceutil/trace.go:171","msg":"trace[1977908536] transaction","detail":"{read_only:false; response_revision:871; number_of_response:1; }","duration":"241.899902ms","start":"2026-02-13T06:59:30.475471Z","end":"2026-02-13T06:59:30.717371Z","steps":["trace[1977908536] 'process raft request' (duration: 149.893229ms)","trace[1977908536] 'compare' (duration: 91.688965ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T06:59:30.71765Z","caller":"traceutil/trace.go:171","msg":"trace[1100697095] transaction","detail":"{read_only:false; response_revision:872; number_of_response:1; }","duration":"241.698627ms","start":"2026-02-13T06:59:30.475928Z","end":"2026-02-13T06:59:30.717627Z","steps":["trace[1100697095] 'process raft request' (duration: 241.371518ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:59:30.718012Z","caller":"traceutil/trace.go:171","msg":"trace[1812847304] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"233.594929ms","start":"2026-02-13T06:59:30.484405Z","end":"2026-02-13T06:59:30.718Z","steps":["trace[1812847304] 'process raft request' (duration: 233.111396ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:59:30.718122Z","caller":"traceutil/trace.go:171","msg":"trace[17253410] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"229.365775ms","start":"2026-02-13T06:59:30.488745Z","end":"2026-02-13T06:59:30.718111Z","steps":["trace[17253410] 'process raft request' (duration: 229.210421ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:59:32.934504Z","caller":"traceutil/trace.go:171","msg":"trace[1913859710] linearizableReadLoop","detail":"{readStateIndex:912; appliedIndex:911; }","duration":"276.998645ms","start":"2026-02-13T06:59:32.657484Z","end":"2026-02-13T06:59:32.934482Z","steps":["trace[1913859710] 'read index received' (duration: 276.776499ms)","trace[1913859710] 'applied index is now lower than readState.Index' (duration: 221.086µs)"],"step_count":2} {"level":"info","ts":"2026-02-13T06:59:32.934627Z","caller":"traceutil/trace.go:171","msg":"trace[769005420] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"459.370987ms","start":"2026-02-13T06:59:32.475247Z","end":"2026-02-13T06:59:32.934618Z","steps":["trace[769005420] 'process raft request' (duration: 459.10944ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:32.934722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:32.475231Z","time spent":"459.422708ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T06:59:32.934813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.200954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-13T06:59:32.934857Z","caller":"traceutil/trace.go:171","msg":"trace[1191064633] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:875; }","duration":"212.272676ms","start":"2026-02-13T06:59:32.722573Z","end":"2026-02-13T06:59:32.934846Z","steps":["trace[1191064633] 'agreement among raft nodes before linearized reading' (duration: 212.158002ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:32.934939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.455607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:59:32.934951Z","caller":"traceutil/trace.go:171","msg":"trace[1357463362] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:875; }","duration":"277.488048ms","start":"2026-02-13T06:59:32.65746Z","end":"2026-02-13T06:59:32.934948Z","steps":["trace[1357463362] 'agreement among raft nodes before linearized reading' (duration: 277.456547ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:32.935061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.617368ms","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-13T06:59:32.935075Z","caller":"traceutil/trace.go:171","msg":"trace[716709693] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:875; }","duration":"211.636379ms","start":"2026-02-13T06:59:32.723434Z","end":"2026-02-13T06:59:32.93507Z","steps":["trace[716709693] 'agreement among raft nodes before linearized reading' (duration: 211.600998ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:32.935128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.717251ms","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-13T06:59:32.935139Z","caller":"traceutil/trace.go:171","msg":"trace[251000748] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:875; }","duration":"211.736991ms","start":"2026-02-13T06:59:32.723398Z","end":"2026-02-13T06:59:32.935135Z","steps":["trace[251000748] 'agreement among raft nodes before linearized reading' (duration: 211.706941ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:32.935401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.778569ms","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-13T06:59:32.935438Z","caller":"traceutil/trace.go:171","msg":"trace[2105081133] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:875; }","duration":"212.82305ms","start":"2026-02-13T06:59:32.722605Z","end":"2026-02-13T06:59:32.935428Z","steps":["trace[2105081133] 'agreement among raft nodes before linearized reading' (duration: 212.700667ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:33.598092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.532495ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T06:59:33.598148Z","caller":"traceutil/trace.go:171","msg":"trace[949259378] transaction","detail":"{read_only:false; response_revision:876; number_of_response:1; }","duration":"658.453349ms","start":"2026-02-13T06:59:32.939685Z","end":"2026-02-13T06:59:33.598138Z","steps":["trace[949259378] 'process raft request' (duration: 263.828861ms)","trace[949259378] 'compare' (duration: 394.370371ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:59:33.598181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:32.939676Z","time spent":"658.4876ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:59:33.601207Z","caller":"traceutil/trace.go:171","msg":"trace[1847310595] linearizableReadLoop","detail":"{readStateIndex:916; appliedIndex:913; }","duration":"241.155542ms","start":"2026-02-13T06:59:33.360044Z","end":"2026-02-13T06:59:33.6012Z","steps":["trace[1847310595] 'read index received' (duration: 241.05594ms)","trace[1847310595] 'applied index is now lower than readState.Index' (duration: 99.202µs)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:59:33.601304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.255945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.235\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-13T06:59:33.601317Z","caller":"traceutil/trace.go:171","msg":"trace[1376388481] range","detail":"{range_begin:/registry/masterleases/199.204.45.235; range_end:; response_count:1; response_revision:879; }","duration":"241.272595ms","start":"2026-02-13T06:59:33.36004Z","end":"2026-02-13T06:59:33.601313Z","steps":["trace[1376388481] 'agreement among raft nodes before linearized reading' (duration: 241.188623ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:59:33.60147Z","caller":"traceutil/trace.go:171","msg":"trace[1327585217] transaction","detail":"{read_only:false; response_revision:879; number_of_response:1; }","duration":"658.448659ms","start":"2026-02-13T06:59:32.943016Z","end":"2026-02-13T06:59:33.601465Z","steps":["trace[1327585217] 'process raft request' (duration: 658.169862ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:33.601508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:32.943009Z","time spent":"658.47966ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:59:33.601559Z","caller":"traceutil/trace.go:171","msg":"trace[1237354939] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"660.727721ms","start":"2026-02-13T06:59:32.940821Z","end":"2026-02-13T06:59:33.601548Z","steps":["trace[1237354939] 'process raft request' (duration: 660.307989ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:33.601613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:32.940814Z","time spent":"660.759041ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:59:33.601649Z","caller":"traceutil/trace.go:171","msg":"trace[1901694003] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"659.634081ms","start":"2026-02-13T06:59:32.942011Z","end":"2026-02-13T06:59:33.601645Z","steps":["trace[1901694003] 'process raft request' (duration: 659.158368ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:33.601671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:32.941995Z","time spent":"659.662622ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T06:59:33.819023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.724553ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:38"} {"level":"info","ts":"2026-02-13T06:59:34.017932Z","caller":"traceutil/trace.go:171","msg":"trace[1910598162] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"198.123616ms","start":"2026-02-13T06:59:33.819788Z","end":"2026-02-13T06:59:34.017911Z","steps":["trace[1910598162] 'process raft request' (duration: 142.698156ms)","trace[1910598162] 'compare' (duration: 55.305596ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T06:59:37.873622Z","caller":"traceutil/trace.go:171","msg":"trace[860445659] linearizableReadLoop","detail":"{readStateIndex:926; appliedIndex:925; }","duration":"213.16854ms","start":"2026-02-13T06:59:37.660439Z","end":"2026-02-13T06:59:37.873607Z","steps":["trace[860445659] 'read index received' (duration: 213.052157ms)","trace[860445659] 'applied index is now lower than readState.Index' (duration: 115.863µs)"],"step_count":2} {"level":"info","ts":"2026-02-13T06:59:37.873827Z","caller":"traceutil/trace.go:171","msg":"trace[1250408176] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"265.597629ms","start":"2026-02-13T06:59:37.608224Z","end":"2026-02-13T06:59:37.873822Z","steps":["trace[1250408176] 'process raft request' (duration: 265.308831ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:37.873978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.52819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-13T06:59:37.873999Z","caller":"traceutil/trace.go:171","msg":"trace[759848514] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:888; }","duration":"213.580411ms","start":"2026-02-13T06:59:37.660414Z","end":"2026-02-13T06:59:37.873994Z","steps":["trace[759848514] 'agreement among raft nodes before linearized reading' (duration: 213.504369ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:37.87409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.11246ms","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-13T06:59:37.874107Z","caller":"traceutil/trace.go:171","msg":"trace[636148592] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:888; }","duration":"177.129461ms","start":"2026-02-13T06:59:37.696973Z","end":"2026-02-13T06:59:37.874103Z","steps":["trace[636148592] 'agreement among raft nodes before linearized reading' (duration: 177.09119ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:37.87421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.202533ms","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-13T06:59:37.874227Z","caller":"traceutil/trace.go:171","msg":"trace[878824752] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:888; }","duration":"177.229084ms","start":"2026-02-13T06:59:37.696995Z","end":"2026-02-13T06:59:37.874224Z","steps":["trace[878824752] 'agreement among raft nodes before linearized reading' (duration: 177.188323ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:39.057114Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.134400203s","expected-duration":"1s"} {"level":"info","ts":"2026-02-13T06:59:39.057371Z","caller":"traceutil/trace.go:171","msg":"trace[219417291] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"1.18045577s","start":"2026-02-13T06:59:37.876896Z","end":"2026-02-13T06:59:39.057352Z","steps":["trace[219417291] 'process raft request' (duration: 1.180336357s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:39.057474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:37.876885Z","time spent":"1.180535012s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:59:39.216288Z","caller":"traceutil/trace.go:171","msg":"trace[1866135920] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"1.338094638s","start":"2026-02-13T06:59:37.878177Z","end":"2026-02-13T06:59:39.216271Z","steps":["trace[1866135920] 'process raft request' (duration: 1.337978725s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:39.216397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:37.878162Z","time spent":"1.3381822s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:59:39.216481Z","caller":"traceutil/trace.go:171","msg":"trace[1860357429] linearizableReadLoop","detail":"{readStateIndex:929; appliedIndex:927; }","duration":"569.079397ms","start":"2026-02-13T06:59:38.647396Z","end":"2026-02-13T06:59:39.216476Z","steps":["trace[1860357429] 'read index received' (duration: 410.465183ms)","trace[1860357429] 'applied index is now lower than readState.Index' (duration: 158.613534ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T06:59:39.216562Z","caller":"traceutil/trace.go:171","msg":"trace[1751932451] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"1.337002439s","start":"2026-02-13T06:59:37.879555Z","end":"2026-02-13T06:59:39.216558Z","steps":["trace[1751932451] 'process raft request' (duration: 1.336692621s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:39.216585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:37.879549Z","time spent":"1.337021829s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T06:59:39.216795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.398275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:59:39.216813Z","caller":"traceutil/trace.go:171","msg":"trace[723518333] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:891; }","duration":"569.441057ms","start":"2026-02-13T06:59:38.647367Z","end":"2026-02-13T06:59:39.216808Z","steps":["trace[723518333] 'agreement among raft nodes before linearized reading' (duration: 569.409526ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:39.216827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:38.647353Z","time spent":"569.471288ms","remote":"127.0.0.1:52758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-13T06:59:39.216831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.852511ms","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-13T06:59:39.216889Z","caller":"traceutil/trace.go:171","msg":"trace[1531764387] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:891; }","duration":"222.937892ms","start":"2026-02-13T06:59:38.993935Z","end":"2026-02-13T06:59:39.216873Z","steps":["trace[1531764387] 'agreement among raft nodes before linearized reading' (duration: 222.720547ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:39.740364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.064194ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:59:39.740478Z","caller":"traceutil/trace.go:171","msg":"trace[105271765] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:892; }","duration":"217.188199ms","start":"2026-02-13T06:59:39.523273Z","end":"2026-02-13T06:59:39.740461Z","steps":["trace[105271765] 'range keys from in-memory index tree' (duration: 217.044634ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:39.943154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.885658ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:26"} {"level":"info","ts":"2026-02-13T06:59:39.943242Z","caller":"traceutil/trace.go:171","msg":"trace[1035863600] linearizableReadLoop","detail":"{readStateIndex:931; appliedIndex:930; }","duration":"292.08529ms","start":"2026-02-13T06:59:39.65114Z","end":"2026-02-13T06:59:39.943225Z","steps":["trace[1035863600] 'read index received' (duration: 4.064879ms)","trace[1035863600] 'applied index is now lower than readState.Index' (duration: 288.019021ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:59:39.943608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.45774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:59:39.943641Z","caller":"traceutil/trace.go:171","msg":"trace[2119375932] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:892; }","duration":"292.526392ms","start":"2026-02-13T06:59:39.651104Z","end":"2026-02-13T06:59:39.943631Z","steps":["trace[2119375932] 'agreement among raft nodes before linearized reading' (duration: 292.46398ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:59:41.688256Z","caller":"traceutil/trace.go:171","msg":"trace[1471923851] linearizableReadLoop","detail":"{readStateIndex:934; appliedIndex:933; }","duration":"466.673904ms","start":"2026-02-13T06:59:41.221551Z","end":"2026-02-13T06:59:41.688225Z","steps":["trace[1471923851] 'read index received' (duration: 466.417957ms)","trace[1471923851] 'applied index is now lower than readState.Index' (duration: 254.827µs)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:59:41.688614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.046714ms","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-13T06:59:41.688667Z","caller":"traceutil/trace.go:171","msg":"trace[33819070] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:895; }","duration":"467.146877ms","start":"2026-02-13T06:59:41.22151Z","end":"2026-02-13T06:59:41.688657Z","steps":["trace[33819070] 'agreement among raft nodes before linearized reading' (duration: 466.989553ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:41.688702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:41.221492Z","time spent":"467.201719ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-13T06:59:41.688445Z","caller":"traceutil/trace.go:171","msg":"trace[140601848] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"623.85048ms","start":"2026-02-13T06:59:41.064575Z","end":"2026-02-13T06:59:41.688426Z","steps":["trace[140601848] 'process raft request' (duration: 623.452229ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:41.688973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:41.06456Z","time spent":"624.303091ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T06:59:41.689422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.798038ms","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-13T06:59:41.689617Z","caller":"traceutil/trace.go:171","msg":"trace[750431157] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:895; }","duration":"467.025544ms","start":"2026-02-13T06:59:41.222572Z","end":"2026-02-13T06:59:41.689598Z","steps":["trace[750431157] 'agreement among raft nodes before linearized reading' (duration: 466.723746ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:41.689948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:41.222562Z","time spent":"467.364423ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-13T06:59:41.689771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.741704ms","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-13T06:59:41.693079Z","caller":"traceutil/trace.go:171","msg":"trace[2145551142] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:895; }","duration":"416.081934ms","start":"2026-02-13T06:59:41.276982Z","end":"2026-02-13T06:59:41.693064Z","steps":["trace[2145551142] 'agreement among raft nodes before linearized reading' (duration: 412.713874ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:41.693173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:41.276964Z","time spent":"416.196158ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-13T06:59:41.866268Z","caller":"traceutil/trace.go:171","msg":"trace[1424845360] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"169.112466ms","start":"2026-02-13T06:59:41.697112Z","end":"2026-02-13T06:59:41.866224Z","steps":["trace[1424845360] 'process raft request' (duration: 165.339985ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:59:41.866761Z","caller":"traceutil/trace.go:171","msg":"trace[670732134] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"167.207895ms","start":"2026-02-13T06:59:41.699546Z","end":"2026-02-13T06:59:41.866754Z","steps":["trace[670732134] 'process raft request' (duration: 167.187875ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:59:41.866898Z","caller":"traceutil/trace.go:171","msg":"trace[1316365999] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"168.342185ms","start":"2026-02-13T06:59:41.69855Z","end":"2026-02-13T06:59:41.866893Z","steps":["trace[1316365999] 'process raft request' (duration: 168.14978ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:59:42.353812Z","caller":"traceutil/trace.go:171","msg":"trace[626850712] transaction","detail":"{read_only:false; response_revision:899; number_of_response:1; }","duration":"386.54669ms","start":"2026-02-13T06:59:41.967243Z","end":"2026-02-13T06:59:42.35379Z","steps":["trace[626850712] 'process raft request' (duration: 306.725874ms)","trace[626850712] 'compare' (duration: 79.080676ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:59:42.356048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:41.967233Z","time spent":"386.636113ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:59:46.492059Z","caller":"traceutil/trace.go:171","msg":"trace[368963944] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"115.002351ms","start":"2026-02-13T06:59:46.377041Z","end":"2026-02-13T06:59:46.492044Z","steps":["trace[368963944] 'process raft request' (duration: 114.907959ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:53.317024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.442158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:59:53.317097Z","caller":"traceutil/trace.go:171","msg":"trace[1374948910] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:969; }","duration":"665.554341ms","start":"2026-02-13T06:59:52.651524Z","end":"2026-02-13T06:59:53.317078Z","steps":["trace[1374948910] 'range keys from in-memory index tree' (duration: 665.380165ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:53.317134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:52.651506Z","time spent":"665.620442ms","remote":"127.0.0.1:52758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-13T06:59:53.317328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.808001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-13T06:59:53.317358Z","caller":"traceutil/trace.go:171","msg":"trace[348019216] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:969; }","duration":"654.864943ms","start":"2026-02-13T06:59:52.662483Z","end":"2026-02-13T06:59:53.317348Z","steps":["trace[348019216] 'count revisions from in-memory index tree' (duration: 654.738879ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:53.317388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:52.662451Z","time spent":"654.927675ms","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":3,"response size":28,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:59:53.317778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.449256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:59:53.317816Z","caller":"traceutil/trace.go:171","msg":"trace[204464997] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:969; }","duration":"470.520028ms","start":"2026-02-13T06:59:52.847281Z","end":"2026-02-13T06:59:53.317801Z","steps":["trace[204464997] 'count revisions from in-memory index tree' (duration: 470.390474ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:53.317844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:52.84726Z","time spent":"470.576329ms","remote":"127.0.0.1:53292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":26,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:59:53.31809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.774979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-02-13T06:59:53.318117Z","caller":"traceutil/trace.go:171","msg":"trace[321840420] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:969; }","duration":"366.840451ms","start":"2026-02-13T06:59:52.951268Z","end":"2026-02-13T06:59:53.318109Z","steps":["trace[321840420] 'range keys from in-memory index tree' (duration: 366.626055ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:59:53.318145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:52.951246Z","time spent":"366.893092ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":495,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-02-13T06:59:55.687525Z","caller":"traceutil/trace.go:171","msg":"trace[206414354] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"110.78083ms","start":"2026-02-13T06:59:55.576722Z","end":"2026-02-13T06:59:55.687503Z","steps":["trace[206414354] 'process raft request' (duration: 90.990038ms)","trace[206414354] 'compare' (duration: 19.303659ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T07:00:00.423993Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920878932738420664,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T07:00:00.925039Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920878932738420664,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-13T07:00:01.033208Z","caller":"traceutil/trace.go:171","msg":"trace[1700166807] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"1.199377763s","start":"2026-02-13T06:59:59.833806Z","end":"2026-02-13T07:00:01.033184Z","steps":["trace[1700166807] 'process raft request' (duration: 1.19924272s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T07:00:01.033347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:59.83377Z","time spent":"1.199503897s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T07:00:01.035902Z","caller":"traceutil/trace.go:171","msg":"trace[1839233584] linearizableReadLoop","detail":"{readStateIndex:1054; appliedIndex:1052; }","duration":"1.112995709s","start":"2026-02-13T06:59:59.922882Z","end":"2026-02-13T07:00:01.035877Z","steps":["trace[1839233584] 'read index received' (duration: 1.110284916s)","trace[1839233584] 'applied index is now lower than readState.Index' (duration: 2.709853ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T07:00:01.036219Z","caller":"traceutil/trace.go:171","msg":"trace[445720015] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"636.988814ms","start":"2026-02-13T07:00:00.399216Z","end":"2026-02-13T07:00:01.036205Z","steps":["trace[445720015] 'process raft request' (duration: 636.567593ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T07:00:01.036322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T07:00:00.399178Z","time spent":"637.071567ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T07:00:01.038139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.077554625s","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-13T07:00:01.038176Z","caller":"traceutil/trace.go:171","msg":"trace[2143107124] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1011; }","duration":"1.077682969s","start":"2026-02-13T06:59:59.960484Z","end":"2026-02-13T07:00:01.038167Z","steps":["trace[2143107124] 'agreement among raft nodes before linearized reading' (duration: 1.077572926s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T07:00:01.038201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:59.960468Z","time spent":"1.07772643s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-13T07:00:01.038326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.115454945s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-13T07:00:01.038354Z","caller":"traceutil/trace.go:171","msg":"trace[223807463] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1011; }","duration":"1.115525657s","start":"2026-02-13T06:59:59.922819Z","end":"2026-02-13T07:00:01.038345Z","steps":["trace[223807463] 'agreement among raft nodes before linearized reading' (duration: 1.115487546s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T07:00:01.038377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:59.922796Z","time spent":"1.115575529s","remote":"127.0.0.1:50370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-02-13T07:00:01.038491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.160878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T07:00:01.038513Z","caller":"traceutil/trace.go:171","msg":"trace[414236673] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1011; }","duration":"386.208858ms","start":"2026-02-13T07:00:00.652298Z","end":"2026-02-13T07:00:01.038507Z","steps":["trace[414236673] 'agreement among raft nodes before linearized reading' (duration: 386.176928ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T07:00:01.038533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T07:00:00.652282Z","time spent":"386.24783ms","remote":"127.0.0.1:52758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-13T07:00:01.038651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.954313ms","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-13T07:00:01.038674Z","caller":"traceutil/trace.go:171","msg":"trace[2072571472] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1011; }","duration":"479.010145ms","start":"2026-02-13T07:00:00.559658Z","end":"2026-02-13T07:00:01.038668Z","steps":["trace[2072571472] 'agreement among raft nodes before linearized reading' (duration: 478.953833ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T07:00:01.038691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T07:00:00.559642Z","time spent":"479.046156ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-13T07:00:01.038801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.015147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:527"} {"level":"info","ts":"2026-02-13T07:00:01.038825Z","caller":"traceutil/trace.go:171","msg":"trace[689647024] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1011; }","duration":"630.065889ms","start":"2026-02-13T07:00:00.408752Z","end":"2026-02-13T07:00:01.038818Z","steps":["trace[689647024] 'agreement among raft nodes before linearized reading' (duration: 630.010057ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T07:00:01.038842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T07:00:00.408735Z","time spent":"630.102799ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":548,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-13T07:00:01.038916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"868.152813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-02-13T07:00:01.038936Z","caller":"traceutil/trace.go:171","msg":"trace[537734950] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1011; }","duration":"868.217305ms","start":"2026-02-13T07:00:00.170713Z","end":"2026-02-13T07:00:01.038931Z","steps":["trace[537734950] 'agreement among raft nodes before linearized reading' (duration: 868.170844ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T07:00:01.038952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T07:00:00.170688Z","time spent":"868.259796ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-13T07:00:01.040822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.071040511s","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-13T07:00:01.040855Z","caller":"traceutil/trace.go:171","msg":"trace[1075490045] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1011; }","duration":"1.071100591s","start":"2026-02-13T06:59:59.969745Z","end":"2026-02-13T07:00:01.040846Z","steps":["trace[1075490045] 'agreement among raft nodes before linearized reading' (duration: 1.071014199s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T07:00:01.040876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:59.969735Z","time spent":"1.071135423s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-13T07:00:01.045124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.072822558s","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-13T07:00:01.045157Z","caller":"traceutil/trace.go:171","msg":"trace[36158366] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1011; }","duration":"1.07287623s","start":"2026-02-13T06:59:59.972274Z","end":"2026-02-13T07:00:01.04515Z","steps":["trace[36158366] 'agreement among raft nodes before linearized reading' (duration: 1.066716815s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T07:00:01.045991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:59:59.972265Z","time spent":"1.072907321s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-13T07:00:05.812928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.131344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T07:00:05.81301Z","caller":"traceutil/trace.go:171","msg":"trace[1412808321] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1033; }","duration":"161.244267ms","start":"2026-02-13T07:00:05.651746Z","end":"2026-02-13T07:00:05.81299Z","steps":["trace[1412808321] 'range keys from in-memory index tree' (duration: 161.080632ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T07:02:23.549111Z","caller":"traceutil/trace.go:171","msg":"trace[878762229] transaction","detail":"{read_only:false; response_revision:1595; number_of_response:1; }","duration":"144.170604ms","start":"2026-02-13T07:02:23.404917Z","end":"2026-02-13T07:02:23.549087Z","steps":["trace[878762229] 'process raft request' (duration: 72.815115ms)","trace[878762229] 'compare' (duration: 71.224766ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T07:02:24.016568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.362108ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T07:02:24.016652Z","caller":"traceutil/trace.go:171","msg":"trace[343941142] linearizableReadLoop","detail":"{readStateIndex:1669; appliedIndex:1668; }","duration":"163.960053ms","start":"2026-02-13T07:02:23.85268Z","end":"2026-02-13T07:02:24.01664Z","steps":["trace[343941142] 'read index received' (duration: 48.41332ms)","trace[343941142] 'applied index is now lower than readState.Index' (duration: 115.546003ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T07:02:24.016714Z","caller":"traceutil/trace.go:171","msg":"trace[1044106694] transaction","detail":"{read_only:false; response_revision:1597; number_of_response:1; }","duration":"166.777594ms","start":"2026-02-13T07:02:23.849928Z","end":"2026-02-13T07:02:24.016705Z","steps":["trace[1044106694] 'process raft request' (duration: 51.210791ms)","trace[1044106694] 'compare' (duration: 115.260916ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T07:02:24.016832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.573707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-13T07:02:24.016874Z","caller":"traceutil/trace.go:171","msg":"trace[720092225] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1597; }","duration":"156.622448ms","start":"2026-02-13T07:02:23.86024Z","end":"2026-02-13T07:02:24.016862Z","steps":["trace[720092225] 'agreement among raft nodes before linearized reading' (duration: 156.496195ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T07:02:24.016959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.278521ms","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-13T07:02:24.016971Z","caller":"traceutil/trace.go:171","msg":"trace[1711590246] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1597; }","duration":"164.303132ms","start":"2026-02-13T07:02:23.852664Z","end":"2026-02-13T07:02:24.016967Z","steps":["trace[1711590246] 'agreement among raft nodes before linearized reading' (duration: 164.267771ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T07:02:24.017073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.012903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-02-13T07:02:24.017087Z","caller":"traceutil/trace.go:171","msg":"trace[417806059] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1597; }","duration":"135.042664ms","start":"2026-02-13T07:02:23.882039Z","end":"2026-02-13T07:02:24.017082Z","steps":["trace[417806059] 'agreement among raft nodes before linearized reading' (duration: 135.003093ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T07:03:04.868422Z","caller":"traceutil/trace.go:171","msg":"trace[1535347282] transaction","detail":"{read_only:false; response_revision:1791; number_of_response:1; }","duration":"139.934048ms","start":"2026-02-13T07:03:04.728474Z","end":"2026-02-13T07:03:04.868408Z","steps":["trace[1535347282] 'process raft request' (duration: 139.557668ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T07:03:43.219772Z","caller":"traceutil/trace.go:171","msg":"trace[2108856995] transaction","detail":"{read_only:false; response_revision:1959; number_of_response:1; }","duration":"102.782484ms","start":"2026-02-13T07:03:43.116965Z","end":"2026-02-13T07:03:43.219748Z","steps":["trace[2108856995] 'process raft request' (duration: 102.321342ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T07:03:44.829071Z","caller":"traceutil/trace.go:171","msg":"trace[2018798706] transaction","detail":"{read_only:false; response_revision:1965; number_of_response:1; }","duration":"210.474635ms","start":"2026-02-13T07:03:44.618569Z","end":"2026-02-13T07:03:44.829044Z","steps":["trace[2018798706] 'process raft request' (duration: 151.48228ms)","trace[2018798706] 'compare' (duration: 58.79882ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T07:03:44.829995Z","caller":"traceutil/trace.go:171","msg":"trace[27246809] transaction","detail":"{read_only:false; response_revision:1966; number_of_response:1; }","duration":"209.990823ms","start":"2026-02-13T07:03:44.619988Z","end":"2026-02-13T07:03:44.829979Z","steps":["trace[27246809] 'process raft request' (duration: 209.014237ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T07:03:44.829727Z","caller":"traceutil/trace.go:171","msg":"trace[1583113526] linearizableReadLoop","detail":"{readStateIndex:2055; appliedIndex:2052; }","duration":"178.455492ms","start":"2026-02-13T07:03:44.651244Z","end":"2026-02-13T07:03:44.829699Z","steps":["trace[1583113526] 'read index received' (duration: 16.563181ms)","trace[1583113526] 'applied index is now lower than readState.Index' (duration: 161.890801ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T07:03:44.829845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.585936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T07:03:44.83093Z","caller":"traceutil/trace.go:171","msg":"trace[1923165089] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1966; }","duration":"179.679084ms","start":"2026-02-13T07:03:44.651232Z","end":"2026-02-13T07:03:44.830911Z","steps":["trace[1923165089] 'agreement among raft nodes before linearized reading' (duration: 178.545614ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T07:03:45.4168Z","caller":"traceutil/trace.go:171","msg":"trace[1785471638] linearizableReadLoop","detail":"{readStateIndex:2057; appliedIndex:2056; }","duration":"148.545555ms","start":"2026-02-13T07:03:45.268234Z","end":"2026-02-13T07:03:45.416779Z","steps":["trace[1785471638] 'read index received' (duration: 56.698685ms)","trace[1785471638] 'applied index is now lower than readState.Index' (duration: 91.84613ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T07:03:45.416937Z","caller":"traceutil/trace.go:171","msg":"trace[1432955382] transaction","detail":"{read_only:false; response_revision:1968; number_of_response:1; }","duration":"184.808897ms","start":"2026-02-13T07:03:45.232108Z","end":"2026-02-13T07:03:45.416917Z","steps":["trace[1432955382] 'process raft request' (duration: 92.863345ms)","trace[1432955382] 'compare' (duration: 91.694036ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T07:03:45.416973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.718219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-02-13T07:03:45.416996Z","caller":"traceutil/trace.go:171","msg":"trace[218748848] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1968; }","duration":"148.800741ms","start":"2026-02-13T07:03:45.268189Z","end":"2026-02-13T07:03:45.41699Z","steps":["trace[218748848] 'agreement among raft nodes before linearized reading' (duration: 148.663188ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T07:03:46.788146Z","caller":"traceutil/trace.go:171","msg":"trace[1029259996] linearizableReadLoop","detail":"{readStateIndex:2060; appliedIndex:2059; }","duration":"185.464294ms","start":"2026-02-13T07:03:46.602659Z","end":"2026-02-13T07:03:46.788124Z","steps":["trace[1029259996] 'read index received' (duration: 185.2895ms)","trace[1029259996] 'applied index is now lower than readState.Index' (duration: 173.934µs)"],"step_count":2} {"level":"info","ts":"2026-02-13T07:03:46.788267Z","caller":"traceutil/trace.go:171","msg":"trace[1763777594] transaction","detail":"{read_only:false; response_revision:1971; number_of_response:1; }","duration":"209.512371ms","start":"2026-02-13T07:03:46.578744Z","end":"2026-02-13T07:03:46.788256Z","steps":["trace[1763777594] 'process raft request' (duration: 209.258374ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T07:03:46.788607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.928877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-g8xzj\" ","response":"range_response_count:1 size:11191"} {"level":"info","ts":"2026-02-13T07:03:46.788647Z","caller":"traceutil/trace.go:171","msg":"trace[95939385] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-g8xzj; range_end:; response_count:1; response_revision:1971; }","duration":"185.981938ms","start":"2026-02-13T07:03:46.602655Z","end":"2026-02-13T07:03:46.788637Z","steps":["trace[95939385] 'agreement among raft nodes before linearized reading' (duration: 185.828224ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T07:03:46.788812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.927762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T07:03:46.78885Z","caller":"traceutil/trace.go:171","msg":"trace[2126099820] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1971; }","duration":"136.995114ms","start":"2026-02-13T07:03:46.651842Z","end":"2026-02-13T07:03:46.788837Z","steps":["trace[2126099820] 'agreement among raft nodes before linearized reading' (duration: 136.947402ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T07:03:46.789736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.728882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-13T07:03:46.790617Z","caller":"traceutil/trace.go:171","msg":"trace[224970245] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1971; }","duration":"118.631776ms","start":"2026-02-13T07:03:46.671969Z","end":"2026-02-13T07:03:46.790601Z","steps":["trace[224970245] 'agreement among raft nodes before linearized reading' (duration: 117.64468ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T07:03:46.947879Z","caller":"traceutil/trace.go:171","msg":"trace[1593189336] linearizableReadLoop","detail":"{readStateIndex:2062; appliedIndex:2060; }","duration":"112.174058ms","start":"2026-02-13T07:03:46.835686Z","end":"2026-02-13T07:03:46.94786Z","steps":["trace[1593189336] 'read index received' (duration: 15.267647ms)","trace[1593189336] 'applied index is now lower than readState.Index' (duration: 96.905681ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T07:03:46.947988Z","caller":"traceutil/trace.go:171","msg":"trace[1363273480] transaction","detail":"{read_only:false; response_revision:1973; number_of_response:1; }","duration":"147.140897ms","start":"2026-02-13T07:03:46.800839Z","end":"2026-02-13T07:03:46.947979Z","steps":["trace[1363273480] 'process raft request' (duration: 99.731354ms)","trace[1363273480] 'compare' (duration: 47.207277ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T07:03:46.94817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.469576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-02-13T07:03:46.948191Z","caller":"traceutil/trace.go:171","msg":"trace[1785092918] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1973; }","duration":"112.529967ms","start":"2026-02-13T07:03:46.835654Z","end":"2026-02-13T07:03:46.948184Z","steps":["trace[1785092918] 'agreement among raft nodes before linearized reading' (duration: 112.432305ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T07:03:46.948274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.553238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-13T07:03:46.948289Z","caller":"traceutil/trace.go:171","msg":"trace[827875189] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1973; }","duration":"112.573739ms","start":"2026-02-13T07:03:46.835711Z","end":"2026-02-13T07:03:46.948284Z","steps":["trace[827875189] 'agreement among raft nodes before linearized reading' (duration: 112.530478ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T07:03:47.171965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.452705ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T07:03:47.17203Z","caller":"traceutil/trace.go:171","msg":"trace[1185564913] linearizableReadLoop","detail":"{readStateIndex:2064; appliedIndex:2063; }","duration":"141.284385ms","start":"2026-02-13T07:03:47.030735Z","end":"2026-02-13T07:03:47.17202Z","steps":["trace[1185564913] 'read index received' (duration: 23.680526ms)","trace[1185564913] 'applied index is now lower than readState.Index' (duration: 117.603019ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T07:03:47.172121Z","caller":"traceutil/trace.go:171","msg":"trace[1384804663] transaction","detail":"{read_only:false; response_revision:1975; number_of_response:1; }","duration":"214.285594ms","start":"2026-02-13T07:03:46.957814Z","end":"2026-02-13T07:03:47.172099Z","steps":["trace[1384804663] 'process raft request' (duration: 96.637284ms)","trace[1384804663] 'compare' (duration: 117.385503ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T07:03:47.172193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.46024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-g8xzj\" ","response":"range_response_count:1 size:11191"} {"level":"info","ts":"2026-02-13T07:03:47.172217Z","caller":"traceutil/trace.go:171","msg":"trace[803370329] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-g8xzj; range_end:; response_count:1; response_revision:1975; }","duration":"141.515441ms","start":"2026-02-13T07:03:47.030696Z","end":"2026-02-13T07:03:47.172211Z","steps":["trace[803370329] 'agreement among raft nodes before linearized reading' (duration: 141.383207ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T07:03:47.832675Z","caller":"traceutil/trace.go:171","msg":"trace[1705961951] transaction","detail":"{read_only:false; response_revision:1977; number_of_response:1; }","duration":"120.74004ms","start":"2026-02-13T07:03:47.711905Z","end":"2026-02-13T07:03:47.832645Z","steps":["trace[1705961951] 'process raft request' (duration: 120.313539ms)"],"step_count":1}