{"level":"warn","ts":"2026-02-17T06:34:26.383189Z","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-17T06:34:26.383371Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38: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.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38: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-17T06:34:26.383465Z","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-17T06:34:26.383511Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-02-17T06:34:26.383542Z","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-17T06:34:26.384244Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]} {"level":"info","ts":"2026-02-17T06:34:26.384376Z","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.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38: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-17T06:34:26.389027Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.408375ms"} {"level":"info","ts":"2026-02-17T06:34:26.404519Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"} {"level":"info","ts":"2026-02-17T06:34:26.404585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"} {"level":"info","ts":"2026-02-17T06:34:26.404602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"} {"level":"info","ts":"2026-02-17T06:34:26.404609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-17T06:34:26.404615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"} {"level":"info","ts":"2026-02-17T06:34:26.404643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"warn","ts":"2026-02-17T06:34:26.410758Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-17T06:34:26.427877Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-17T06:34:26.429876Z","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-17T06:34:26.434929Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-17T06:34:26.438513Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-17T06:34:26.438658Z","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-17T06:34:26.438687Z","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-17T06:34:26.438697Z","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-17T06:34:26.438905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"info","ts":"2026-02-17T06:34:26.438971Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-02-17T06:34:26.46124Z","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-17T06:34:26.461533Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-02-17T06:34:26.461673Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-02-17T06:34:26.461738Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-17T06:34:26.461758Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-17T06:34:27.206127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"} {"level":"info","ts":"2026-02-17T06:34:27.206174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-17T06:34:27.20619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"} {"level":"info","ts":"2026-02-17T06:34:27.206209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"} {"level":"info","ts":"2026-02-17T06:34:27.206214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-02-17T06:34:27.206226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"} {"level":"info","ts":"2026-02-17T06:34:27.206232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-02-17T06:34:27.207989Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T06:34:27.209868Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"} {"level":"info","ts":"2026-02-17T06:34:27.21039Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T06:34:27.21068Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T06:34:27.210795Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-17T06:34:27.210808Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-17T06:34:27.211417Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T06:34:27.219339Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T06:34:27.219362Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T06:34:27.224661Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"info","ts":"2026-02-17T06:34:27.230678Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-02-17T06:34:44.169022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.587177ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T06:34:44.169176Z","caller":"traceutil/trace.go:171","msg":"trace[1461470511] linearizableReadLoop","detail":"{readStateIndex:393; appliedIndex:392; }","duration":"479.556534ms","start":"2026-02-17T06:34:43.689597Z","end":"2026-02-17T06:34:44.169154Z","steps":["trace[1461470511] 'read index received' (duration: 49.461µs)","trace[1461470511] 'applied index is now lower than readState.Index' (duration: 479.505343ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:34:44.1692Z","caller":"traceutil/trace.go:171","msg":"trace[213509145] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"850.551916ms","start":"2026-02-17T06:34:43.318619Z","end":"2026-02-17T06:34:44.169171Z","steps":["trace[213509145] 'process raft request' (duration: 222.140138ms)","trace[213509145] 'compare' (duration: 627.269139ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:34:44.1693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.689727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:34:44.169333Z","caller":"traceutil/trace.go:171","msg":"trace[1748775401] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:383; }","duration":"479.773909ms","start":"2026-02-17T06:34:43.689547Z","end":"2026-02-17T06:34:44.169321Z","steps":["trace[1748775401] 'agreement among raft nodes before linearized reading' (duration: 479.675096ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:34:44.169337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:34:43.318585Z","time spent":"850.680629ms","remote":"127.0.0.1:34744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3656,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T06:34:44.16937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:34:43.689522Z","time spent":"479.839891ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T06:34:44.295462Z","caller":"traceutil/trace.go:171","msg":"trace[1351599624] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"104.630342ms","start":"2026-02-17T06:34:44.190785Z","end":"2026-02-17T06:34:44.295415Z","steps":["trace[1351599624] 'process raft request' (duration: 104.57277ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:34:44.295662Z","caller":"traceutil/trace.go:171","msg":"trace[689540699] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"116.781577ms","start":"2026-02-17T06:34:44.178852Z","end":"2026-02-17T06:34:44.295634Z","steps":["trace[689540699] 'process raft request' (duration: 111.773961ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:34:44.295829Z","caller":"traceutil/trace.go:171","msg":"trace[1289044267] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"105.110804ms","start":"2026-02-17T06:34:44.190703Z","end":"2026-02-17T06:34:44.295814Z","steps":["trace[1289044267] 'process raft request' (duration: 104.55659ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:34:52.850597Z","caller":"traceutil/trace.go:171","msg":"trace[1550112921] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"129.730524ms","start":"2026-02-17T06:34:52.720851Z","end":"2026-02-17T06:34:52.850581Z","steps":["trace[1550112921] 'process raft request' (duration: 129.641852ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:34:58.654869Z","caller":"traceutil/trace.go:171","msg":"trace[563333347] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"353.849232ms","start":"2026-02-17T06:34:58.301006Z","end":"2026-02-17T06:34:58.654855Z","steps":["trace[563333347] 'process raft request' (duration: 353.757829ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:34:58.655078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:34:58.300987Z","time spent":"353.943123ms","remote":"127.0.0.1:34496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4609,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:34:59.457427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.306154ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T06:34:59.458151Z","caller":"traceutil/trace.go:171","msg":"trace[2125859204] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:518; }","duration":"950.094511ms","start":"2026-02-17T06:34:58.508039Z","end":"2026-02-17T06:34:59.458134Z","steps":["trace[2125859204] 'read index received' (duration: 147.518361ms)","trace[2125859204] 'applied index is now lower than readState.Index' (duration: 802.57446ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:34:59.458591Z","caller":"traceutil/trace.go:171","msg":"trace[1922170924] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"1.148868911s","start":"2026-02-17T06:34:58.309705Z","end":"2026-02-17T06:34:59.458574Z","steps":["trace[1922170924] 'process raft request' (duration: 1.045358477s)","trace[1922170924] 'compare' (duration: 101.630757ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:34:59.458684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:34:58.309696Z","time spent":"1.148940013s","remote":"127.0.0.1:34366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T06:34:59.458835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"950.794629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:34:59.458874Z","caller":"traceutil/trace.go:171","msg":"trace[1850069285] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:505; }","duration":"950.858831ms","start":"2026-02-17T06:34:58.508002Z","end":"2026-02-17T06:34:59.458861Z","steps":["trace[1850069285] 'agreement among raft nodes before linearized reading' (duration: 950.781199ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:34:59.458908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:34:58.507986Z","time spent":"950.915832ms","remote":"127.0.0.1:34366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"info","ts":"2026-02-17T06:34:59.657402Z","caller":"traceutil/trace.go:171","msg":"trace[1564234334] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"346.068985ms","start":"2026-02-17T06:34:59.311318Z","end":"2026-02-17T06:34:59.657387Z","steps":["trace[1564234334] 'process raft request' (duration: 346.046834ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:34:59.657533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:34:59.311295Z","time spent":"346.176648ms","remote":"127.0.0.1:34366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T06:34:59.657872Z","caller":"traceutil/trace.go:171","msg":"trace[655543210] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"997.193655ms","start":"2026-02-17T06:34:58.660671Z","end":"2026-02-17T06:34:59.657864Z","steps":["trace[655543210] 'process raft request' (duration: 996.555809ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:34:59.657922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:34:58.660656Z","time spent":"997.238006ms","remote":"127.0.0.1:34744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4365,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:34:59.658045Z","caller":"traceutil/trace.go:171","msg":"trace[707888219] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"749.415972ms","start":"2026-02-17T06:34:58.908624Z","end":"2026-02-17T06:34:59.65804Z","steps":["trace[707888219] 'process raft request' (duration: 748.714314ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:34:59.65808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:34:58.908604Z","time spent":"749.460433ms","remote":"127.0.0.1:34366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T06:34:59.658416Z","caller":"traceutil/trace.go:171","msg":"trace[479404756] linearizableReadLoop","detail":"{readStateIndex:522; appliedIndex:522; }","duration":"200.094072ms","start":"2026-02-17T06:34:59.458313Z","end":"2026-02-17T06:34:59.658407Z","steps":["trace[479404756] 'read index received' (duration: 200.089442ms)","trace[479404756] 'applied index is now lower than readState.Index' (duration: 3.84µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:34:59.658513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.691011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-02-17T06:34:59.65853Z","caller":"traceutil/trace.go:171","msg":"trace[2118672804] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:508; }","duration":"505.751582ms","start":"2026-02-17T06:34:59.152774Z","end":"2026-02-17T06:34:59.658525Z","steps":["trace[2118672804] 'agreement among raft nodes before linearized reading' (duration: 505.67759ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:34:59.658548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:34:59.152753Z","time spent":"505.791223ms","remote":"127.0.0.1:34550","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":"warn","ts":"2026-02-17T06:34:59.658645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.585505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"} {"level":"info","ts":"2026-02-17T06:34:59.658661Z","caller":"traceutil/trace.go:171","msg":"trace[928249802] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:508; }","duration":"551.625525ms","start":"2026-02-17T06:34:59.10703Z","end":"2026-02-17T06:34:59.658656Z","steps":["trace[928249802] 'agreement among raft nodes before linearized reading' (duration: 551.595745ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:34:59.658677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:34:59.107018Z","time spent":"551.655177ms","remote":"127.0.0.1:34366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4355,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "} {"level":"warn","ts":"2026-02-17T06:34:59.65877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.377054ms","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-17T06:34:59.658786Z","caller":"traceutil/trace.go:171","msg":"trace[1285300004] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:508; }","duration":"581.440026ms","start":"2026-02-17T06:34:59.077341Z","end":"2026-02-17T06:34:59.658781Z","steps":["trace[1285300004] 'agreement among raft nodes before linearized reading' (duration: 581.391154ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:34:59.658802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:34:59.077319Z","time spent":"581.479367ms","remote":"127.0.0.1:34550","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-17T06:34:59.674314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.556941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-17T06:34:59.674364Z","caller":"traceutil/trace.go:171","msg":"trace[1962023403] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:508; }","duration":"597.698934ms","start":"2026-02-17T06:34:59.076654Z","end":"2026-02-17T06:34:59.674353Z","steps":["trace[1962023403] 'agreement among raft nodes before linearized reading' (duration: 597.589862ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:34:59.674411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:34:59.076635Z","time spent":"597.771387ms","remote":"127.0.0.1:34550","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-17T06:34:59.674475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.77523ms","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-17T06:34:59.674492Z","caller":"traceutil/trace.go:171","msg":"trace[497381236] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:508; }","duration":"687.789781ms","start":"2026-02-17T06:34:58.986696Z","end":"2026-02-17T06:34:59.674486Z","steps":["trace[497381236] 'agreement among raft nodes before linearized reading' (duration: 687.75923ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:34:59.674506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:34:58.986654Z","time spent":"687.849382ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-17T06:34:59.674553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.842195ms","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-17T06:34:59.674567Z","caller":"traceutil/trace.go:171","msg":"trace[23361912] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:508; }","duration":"798.880316ms","start":"2026-02-17T06:34:58.875682Z","end":"2026-02-17T06:34:59.674562Z","steps":["trace[23361912] 'agreement among raft nodes before linearized reading' (duration: 798.855765ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:34:59.674582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:34:58.875649Z","time spent":"798.929077ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T06:34:59.675421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"987.767867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:34:59.675444Z","caller":"traceutil/trace.go:171","msg":"trace[1990534997] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:508; }","duration":"987.819859ms","start":"2026-02-17T06:34:58.687618Z","end":"2026-02-17T06:34:59.675438Z","steps":["trace[1990534997] 'agreement among raft nodes before linearized reading' (duration: 987.786578ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:34:59.675513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:34:58.687604Z","time spent":"987.90287ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T06:34:59.675733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"968.975565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:34:59.675754Z","caller":"traceutil/trace.go:171","msg":"trace[37984697] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:508; }","duration":"969.066986ms","start":"2026-02-17T06:34:58.706682Z","end":"2026-02-17T06:34:59.675749Z","steps":["trace[37984697] 'agreement among raft nodes before linearized reading' (duration: 967.932068ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:34:59.67588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:34:58.706671Z","time spent":"969.203081ms","remote":"127.0.0.1:34366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"info","ts":"2026-02-17T06:34:59.680064Z","caller":"traceutil/trace.go:171","msg":"trace[827684779] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"202.851432ms","start":"2026-02-17T06:34:59.477206Z","end":"2026-02-17T06:34:59.680058Z","steps":["trace[827684779] 'process raft request' (duration: 202.695238ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:34:59.680216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.767146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-02-17T06:34:59.680232Z","caller":"traceutil/trace.go:171","msg":"trace[1405364308] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:510; }","duration":"172.821427ms","start":"2026-02-17T06:34:59.507405Z","end":"2026-02-17T06:34:59.680226Z","steps":["trace[1405364308] 'agreement among raft nodes before linearized reading' (duration: 172.788686ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:35:01.529865Z","caller":"traceutil/trace.go:171","msg":"trace[1533050017] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:542; }","duration":"222.696763ms","start":"2026-02-17T06:35:01.307143Z","end":"2026-02-17T06:35:01.52984Z","steps":["trace[1533050017] 'read index received' (duration: 222.462007ms)","trace[1533050017] 'applied index is now lower than readState.Index' (duration: 234.196µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:35:01.529956Z","caller":"traceutil/trace.go:171","msg":"trace[2137580440] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"253.506267ms","start":"2026-02-17T06:35:01.276445Z","end":"2026-02-17T06:35:01.529951Z","steps":["trace[2137580440] 'process raft request' (duration: 253.2077ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:01.53023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.056722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-02-17T06:35:01.530249Z","caller":"traceutil/trace.go:171","msg":"trace[658197847] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:528; }","duration":"223.150374ms","start":"2026-02-17T06:35:01.307092Z","end":"2026-02-17T06:35:01.530242Z","steps":["trace[658197847] 'agreement among raft nodes before linearized reading' (duration: 223.046081ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:07.187579Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757018494557415612,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T06:35:07.352234Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.028727437s","expected-duration":"1s"} {"level":"info","ts":"2026-02-17T06:35:07.352618Z","caller":"traceutil/trace.go:171","msg":"trace[1825421352] linearizableReadLoop","detail":"{readStateIndex:566; appliedIndex:565; }","duration":"665.281696ms","start":"2026-02-17T06:35:06.687317Z","end":"2026-02-17T06:35:07.352598Z","steps":["trace[1825421352] 'read index received' (duration: 665.03243ms)","trace[1825421352] 'applied index is now lower than readState.Index' (duration: 248.316µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:35:07.352747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.433189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:07.352937Z","caller":"traceutil/trace.go:171","msg":"trace[1962125312] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:550; }","duration":"665.517001ms","start":"2026-02-17T06:35:06.687249Z","end":"2026-02-17T06:35:07.352766Z","steps":["trace[1962125312] 'agreement among raft nodes before linearized reading' (duration: 665.401078ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:07.353015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:06.687231Z","time spent":"665.774198ms","remote":"127.0.0.1:34334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T06:35:07.35326Z","caller":"traceutil/trace.go:171","msg":"trace[1239221574] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"1.029936907s","start":"2026-02-17T06:35:06.323312Z","end":"2026-02-17T06:35:07.353249Z","steps":["trace[1239221574] 'process raft request' (duration: 1.029162748s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:07.353335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:06.323289Z","time spent":"1.029993739s","remote":"127.0.0.1:34496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:35:12.88797Z","caller":"traceutil/trace.go:171","msg":"trace[318562273] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:604; }","duration":"190.747658ms","start":"2026-02-17T06:35:12.697196Z","end":"2026-02-17T06:35:12.887944Z","steps":["trace[318562273] 'read index received' (duration: 186.45434ms)","trace[318562273] 'applied index is now lower than readState.Index' (duration: 4.291968ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:35:12.888012Z","caller":"traceutil/trace.go:171","msg":"trace[1045633937] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"260.369651ms","start":"2026-02-17T06:35:12.627633Z","end":"2026-02-17T06:35:12.888003Z","steps":["trace[1045633937] 'process raft request' (duration: 256.058032ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:12.888075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.858672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:12.889672Z","caller":"traceutil/trace.go:171","msg":"trace[1111641663] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:588; }","duration":"192.483522ms","start":"2026-02-17T06:35:12.697168Z","end":"2026-02-17T06:35:12.889651Z","steps":["trace[1111641663] 'agreement among raft nodes before linearized reading' (duration: 190.869052ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:35:19.957194Z","caller":"traceutil/trace.go:171","msg":"trace[1546487662] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"258.583855ms","start":"2026-02-17T06:35:19.698598Z","end":"2026-02-17T06:35:19.957181Z","steps":["trace[1546487662] 'read index received' (duration: 258.471192ms)","trace[1546487662] 'applied index is now lower than readState.Index' (duration: 111.903µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:35:19.957317Z","caller":"traceutil/trace.go:171","msg":"trace[858967627] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"262.742309ms","start":"2026-02-17T06:35:19.694568Z","end":"2026-02-17T06:35:19.95731Z","steps":["trace[858967627] 'process raft request' (duration: 262.534244ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:19.957467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.863022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:19.957489Z","caller":"traceutil/trace.go:171","msg":"trace[167041546] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"258.921084ms","start":"2026-02-17T06:35:19.698562Z","end":"2026-02-17T06:35:19.957483Z","steps":["trace[167041546] 'agreement among raft nodes before linearized reading' (duration: 258.867002ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:35:20.423936Z","caller":"traceutil/trace.go:171","msg":"trace[738135162] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:652; }","duration":"466.68798ms","start":"2026-02-17T06:35:19.957234Z","end":"2026-02-17T06:35:20.423922Z","steps":["trace[738135162] 'read index received' (duration: 466.545136ms)","trace[738135162] 'applied index is now lower than readState.Index' (duration: 142.324µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:35:20.424051Z","caller":"traceutil/trace.go:171","msg":"trace[257992455] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"716.172766ms","start":"2026-02-17T06:35:19.707874Z","end":"2026-02-17T06:35:20.424046Z","steps":["trace[257992455] 'process raft request' (duration: 715.94687ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:20.424107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:19.707857Z","time spent":"716.208317ms","remote":"127.0.0.1:60938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2260,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T06:35:20.424231Z","caller":"traceutil/trace.go:171","msg":"trace[220261242] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"697.786413ms","start":"2026-02-17T06:35:19.726439Z","end":"2026-02-17T06:35:20.424226Z","steps":["trace[220261242] 'process raft request' (duration: 697.449815ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:20.42425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:19.726187Z","time spent":"698.054351ms","remote":"127.0.0.1:60938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2261,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T06:35:20.424413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.175131ms","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-17T06:35:20.424428Z","caller":"traceutil/trace.go:171","msg":"trace[1681673257] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:635; }","duration":"523.201051ms","start":"2026-02-17T06:35:19.901223Z","end":"2026-02-17T06:35:20.424424Z","steps":["trace[1681673257] 'agreement among raft nodes before linearized reading' (duration: 523.093789ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:20.424441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:19.90122Z","time spent":"523.219302ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-17T06:35:20.424538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.342655ms","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-17T06:35:20.42455Z","caller":"traceutil/trace.go:171","msg":"trace[855117265] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:635; }","duration":"523.388507ms","start":"2026-02-17T06:35:19.901158Z","end":"2026-02-17T06:35:20.424547Z","steps":["trace[855117265] 'agreement among raft nodes before linearized reading' (duration: 523.352166ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:20.424565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:19.901144Z","time spent":"523.416057ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-17T06:35:20.424643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.720213ms","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-17T06:35:20.424655Z","caller":"traceutil/trace.go:171","msg":"trace[1732348758] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:635; }","duration":"573.747943ms","start":"2026-02-17T06:35:19.850903Z","end":"2026-02-17T06:35:20.424651Z","steps":["trace[1732348758] 'agreement among raft nodes before linearized reading' (duration: 573.706422ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:20.424666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:19.850895Z","time spent":"573.767934ms","remote":"127.0.0.1:34550","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-17T06:35:20.424737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.019236ms","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-17T06:35:20.42475Z","caller":"traceutil/trace.go:171","msg":"trace[2132768543] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:635; }","duration":"580.020872ms","start":"2026-02-17T06:35:19.844724Z","end":"2026-02-17T06:35:20.424745Z","steps":["trace[2132768543] 'agreement among raft nodes before linearized reading' (duration: 579.986391ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:20.42476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:19.844705Z","time spent":"580.052622ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-17T06:35:20.424827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.486714ms","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-17T06:35:20.424838Z","caller":"traceutil/trace.go:171","msg":"trace[19271146] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:635; }","duration":"582.521304ms","start":"2026-02-17T06:35:19.842313Z","end":"2026-02-17T06:35:20.424835Z","steps":["trace[19271146] 'agreement among raft nodes before linearized reading' (duration: 582.490023ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:20.424849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:19.8423Z","time spent":"582.546675ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T06:35:20.424919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.771502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:20.424932Z","caller":"traceutil/trace.go:171","msg":"trace[636024580] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"464.809443ms","start":"2026-02-17T06:35:19.960117Z","end":"2026-02-17T06:35:20.424927Z","steps":["trace[636024580] 'agreement among raft nodes before linearized reading' (duration: 464.790173ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:20.424944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:19.9601Z","time spent":"464.839943ms","remote":"127.0.0.1:34334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T06:35:22.75492Z","caller":"traceutil/trace.go:171","msg":"trace[2131260832] linearizableReadLoop","detail":"{readStateIndex:700; appliedIndex:699; }","duration":"307.140316ms","start":"2026-02-17T06:35:22.44776Z","end":"2026-02-17T06:35:22.7549Z","steps":["trace[2131260832] 'read index received' (duration: 306.949282ms)","trace[2131260832] 'applied index is now lower than readState.Index' (duration: 190.364µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:35:22.755Z","caller":"traceutil/trace.go:171","msg":"trace[1836093278] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"310.331467ms","start":"2026-02-17T06:35:22.444663Z","end":"2026-02-17T06:35:22.754994Z","steps":["trace[1836093278] 'process raft request' (duration: 310.101281ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:22.755118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:22.444653Z","time spent":"310.373868ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:35:22.755278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.560317ms","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-17T06:35:22.7553Z","caller":"traceutil/trace.go:171","msg":"trace[1544876230] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:680; }","duration":"307.589447ms","start":"2026-02-17T06:35:22.447702Z","end":"2026-02-17T06:35:22.755292Z","steps":["trace[1544876230] 'agreement among raft nodes before linearized reading' (duration: 307.511665ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:22.75532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:22.447679Z","time spent":"307.636739ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-17T06:35:22.755506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.635329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-02-17T06:35:22.755552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.616358ms","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-17T06:35:22.755574Z","caller":"traceutil/trace.go:171","msg":"trace[1840720307] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:680; }","duration":"301.647088ms","start":"2026-02-17T06:35:22.453921Z","end":"2026-02-17T06:35:22.755568Z","steps":["trace[1840720307] 'agreement among raft nodes before linearized reading' (duration: 301.592607ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:35:22.755577Z","caller":"traceutil/trace.go:171","msg":"trace[1945886311] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:680; }","duration":"307.736981ms","start":"2026-02-17T06:35:22.447825Z","end":"2026-02-17T06:35:22.755562Z","steps":["trace[1945886311] 'agreement among raft nodes before linearized reading' (duration: 307.545826ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:22.75559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:22.453914Z","time spent":"301.672899ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-17T06:35:22.755611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:22.447805Z","time spent":"307.800263ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-17T06:35:22.756844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.790527ms","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-17T06:35:22.756882Z","caller":"traceutil/trace.go:171","msg":"trace[1547778034] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:680; }","duration":"304.846429ms","start":"2026-02-17T06:35:22.452026Z","end":"2026-02-17T06:35:22.756873Z","steps":["trace[1547778034] 'agreement among raft nodes before linearized reading' (duration: 303.735131ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:22.756902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:22.452019Z","time spent":"304.87826ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T06:35:23.003307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.864395ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T06:35:23.003565Z","caller":"traceutil/trace.go:171","msg":"trace[1073108471] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"239.233598ms","start":"2026-02-17T06:35:22.764314Z","end":"2026-02-17T06:35:23.003547Z","steps":["trace[1073108471] 'process raft request' (duration: 239.196388ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:35:23.003659Z","caller":"traceutil/trace.go:171","msg":"trace[654397486] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"241.6713ms","start":"2026-02-17T06:35:22.761967Z","end":"2026-02-17T06:35:23.003638Z","steps":["trace[654397486] 'process raft request' (duration: 241.430144ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:35:23.003767Z","caller":"traceutil/trace.go:171","msg":"trace[775142013] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"244.363258ms","start":"2026-02-17T06:35:22.759397Z","end":"2026-02-17T06:35:23.00376Z","steps":["trace[775142013] 'process raft request' (duration: 125.954729ms)","trace[775142013] 'compare' (duration: 117.691441ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:35:23.003821Z","caller":"traceutil/trace.go:171","msg":"trace[1483419029] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"241.023633ms","start":"2026-02-17T06:35:22.762792Z","end":"2026-02-17T06:35:23.003816Z","steps":["trace[1483419029] 'process raft request' (duration: 240.680345ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:35:23.205752Z","caller":"traceutil/trace.go:171","msg":"trace[22640855] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"260.882523ms","start":"2026-02-17T06:35:22.944854Z","end":"2026-02-17T06:35:23.205737Z","steps":["trace[22640855] 'process raft request' (duration: 260.792461ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:35:28.92945Z","caller":"traceutil/trace.go:171","msg":"trace[2085851290] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"115.609678ms","start":"2026-02-17T06:35:28.813821Z","end":"2026-02-17T06:35:28.92943Z","steps":["trace[2085851290] 'process raft request' (duration: 115.516546ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:29.591189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.562307ms","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-17T06:35:29.591242Z","caller":"traceutil/trace.go:171","msg":"trace[1988224561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:697; }","duration":"565.623619ms","start":"2026-02-17T06:35:29.025605Z","end":"2026-02-17T06:35:29.591228Z","steps":["trace[1988224561] 'range keys from in-memory index tree' (duration: 565.460785ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:29.591268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:29.025565Z","time spent":"565.69792ms","remote":"127.0.0.1:34550","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-17T06:35:29.591414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.201847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-17T06:35:29.591432Z","caller":"traceutil/trace.go:171","msg":"trace[404328294] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:697; }","duration":"559.233958ms","start":"2026-02-17T06:35:29.032192Z","end":"2026-02-17T06:35:29.591426Z","steps":["trace[404328294] 'range keys from in-memory index tree' (duration: 559.143325ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:29.591449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:29.032185Z","time spent":"559.258979ms","remote":"127.0.0.1:34550","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-17T06:35:29.59155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.086985ms","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-17T06:35:29.591568Z","caller":"traceutil/trace.go:171","msg":"trace[1847346654] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:697; }","duration":"559.116715ms","start":"2026-02-17T06:35:29.032446Z","end":"2026-02-17T06:35:29.591563Z","steps":["trace[1847346654] 'range keys from in-memory index tree' (duration: 559.040233ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:29.591584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:29.032441Z","time spent":"559.139375ms","remote":"127.0.0.1:34550","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-17T06:35:29.591709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.392867ms","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-17T06:35:29.591727Z","caller":"traceutil/trace.go:171","msg":"trace[1072557222] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:697; }","duration":"558.420288ms","start":"2026-02-17T06:35:29.0333Z","end":"2026-02-17T06:35:29.591721Z","steps":["trace[1072557222] 'range keys from in-memory index tree' (duration: 558.342396ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:29.59176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:29.033293Z","time spent":"558.462249ms","remote":"127.0.0.1:34550","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-17T06:35:29.591938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.567589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:29.591957Z","caller":"traceutil/trace.go:171","msg":"trace[1871056895] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:697; }","duration":"418.611291ms","start":"2026-02-17T06:35:29.17334Z","end":"2026-02-17T06:35:29.591952Z","steps":["trace[1871056895] 'count revisions from in-memory index tree' (duration: 418.524038ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:29.591974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:29.173327Z","time spent":"418.642511ms","remote":"127.0.0.1:34440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":27,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"info","ts":"2026-02-17T06:35:29.592432Z","caller":"traceutil/trace.go:171","msg":"trace[1873898055] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"159.742669ms","start":"2026-02-17T06:35:29.432681Z","end":"2026-02-17T06:35:29.592424Z","steps":["trace[1873898055] 'process raft request' (duration: 120.577834ms)","trace[1873898055] 'compare' (duration: 37.642756ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:35:33.787318Z","caller":"traceutil/trace.go:171","msg":"trace[612117391] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"139.576141ms","start":"2026-02-17T06:35:33.647728Z","end":"2026-02-17T06:35:33.787304Z","steps":["trace[612117391] 'process raft request' (duration: 139.458768ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:35:45.59461Z","caller":"traceutil/trace.go:171","msg":"trace[1926173399] linearizableReadLoop","detail":"{readStateIndex:775; appliedIndex:774; }","duration":"358.4148ms","start":"2026-02-17T06:35:45.236172Z","end":"2026-02-17T06:35:45.594587Z","steps":["trace[1926173399] 'read index received' (duration: 358.339557ms)","trace[1926173399] 'applied index is now lower than readState.Index' (duration: 74.343µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:35:45.594733Z","caller":"traceutil/trace.go:171","msg":"trace[1904068656] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"612.98285ms","start":"2026-02-17T06:35:44.98174Z","end":"2026-02-17T06:35:45.594723Z","steps":["trace[1904068656] 'process raft request' (duration: 612.736274ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:45.594849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:44.981728Z","time spent":"613.028711ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:35:45.594852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.630306ms","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-17T06:35:45.594906Z","caller":"traceutil/trace.go:171","msg":"trace[423652413] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:750; }","duration":"358.751179ms","start":"2026-02-17T06:35:45.236141Z","end":"2026-02-17T06:35:45.594892Z","steps":["trace[423652413] 'agreement among raft nodes before linearized reading' (duration: 358.624285ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:45.594935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:45.236129Z","time spent":"358.799131ms","remote":"127.0.0.1:34484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":2,"response size":29,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-02-17T06:35:48.189495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.275075ms","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-17T06:35:48.189561Z","caller":"traceutil/trace.go:171","msg":"trace[622359894] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:755; }","duration":"277.370169ms","start":"2026-02-17T06:35:47.912172Z","end":"2026-02-17T06:35:48.189542Z","steps":["trace[622359894] 'range keys from in-memory index tree' (duration: 277.08165ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:48.189535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.052454ms","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-17T06:35:48.189996Z","caller":"traceutil/trace.go:171","msg":"trace[597308847] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:755; }","duration":"259.545128ms","start":"2026-02-17T06:35:47.930436Z","end":"2026-02-17T06:35:48.189981Z","steps":["trace[597308847] 'range keys from in-memory index tree' (duration: 258.92411ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:48.189885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.056637ms","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-17T06:35:48.190796Z","caller":"traceutil/trace.go:171","msg":"trace[1415370928] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:755; }","duration":"343.986292ms","start":"2026-02-17T06:35:47.846783Z","end":"2026-02-17T06:35:48.190769Z","steps":["trace[1415370928] 'range keys from in-memory index tree' (duration: 342.962764ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:48.190838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:47.846759Z","time spent":"344.068135ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-17T06:35:48.189928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.995087ms","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-17T06:35:48.190964Z","caller":"traceutil/trace.go:171","msg":"trace[387710172] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:755; }","duration":"331.028316ms","start":"2026-02-17T06:35:47.859929Z","end":"2026-02-17T06:35:48.190957Z","steps":["trace[387710172] 'range keys from in-memory index tree' (duration: 329.928925ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:48.190986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:47.859892Z","time spent":"331.087867ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-17T06:35:48.362001Z","caller":"traceutil/trace.go:171","msg":"trace[1582305161] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"162.208567ms","start":"2026-02-17T06:35:48.199584Z","end":"2026-02-17T06:35:48.361792Z","steps":["trace[1582305161] 'process raft request' (duration: 162.170496ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:35:48.362888Z","caller":"traceutil/trace.go:171","msg":"trace[1018245872] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"165.525438ms","start":"2026-02-17T06:35:48.197348Z","end":"2026-02-17T06:35:48.362873Z","steps":["trace[1018245872] 'process raft request' (duration: 130.507483ms)","trace[1018245872] 'compare' (duration: 33.609226ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:35:48.363563Z","caller":"traceutil/trace.go:171","msg":"trace[1189367580] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"166.114974ms","start":"2026-02-17T06:35:48.197433Z","end":"2026-02-17T06:35:48.363548Z","steps":["trace[1189367580] 'process raft request' (duration: 164.269243ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:35:50.194092Z","caller":"traceutil/trace.go:171","msg":"trace[1984319946] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"499.66843ms","start":"2026-02-17T06:35:49.694361Z","end":"2026-02-17T06:35:50.19403Z","steps":["trace[1984319946] 'process raft request' (duration: 499.289929ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:50.194449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:49.694349Z","time spent":"499.811223ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:35:50.378194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.733953ms","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-17T06:35:50.37831Z","caller":"traceutil/trace.go:171","msg":"trace[593247823] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:760; }","duration":"137.899677ms","start":"2026-02-17T06:35:50.24039Z","end":"2026-02-17T06:35:50.37829Z","steps":["trace[593247823] 'range keys from in-memory index tree' (duration: 137.551337ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:50.987739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.463725ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T06:35:50.987938Z","caller":"traceutil/trace.go:171","msg":"trace[719316867] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"601.737841ms","start":"2026-02-17T06:35:50.386186Z","end":"2026-02-17T06:35:50.987924Z","steps":["trace[719316867] 'process raft request' (duration: 94.025949ms)","trace[719316867] 'compare' (duration: 507.158846ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:35:50.987986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:50.386176Z","time spent":"601.790673ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:35:50.988461Z","caller":"traceutil/trace.go:171","msg":"trace[673474572] linearizableReadLoop","detail":"{readStateIndex:792; appliedIndex:787; }","duration":"298.751027ms","start":"2026-02-17T06:35:50.689703Z","end":"2026-02-17T06:35:50.988454Z","steps":["trace[673474572] 'read index received' (duration: 57.515594ms)","trace[673474572] 'applied index is now lower than readState.Index' (duration: 241.234733ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:35:50.988558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.85313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:50.988578Z","caller":"traceutil/trace.go:171","msg":"trace[1548307866] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:765; }","duration":"298.913981ms","start":"2026-02-17T06:35:50.689659Z","end":"2026-02-17T06:35:50.988573Z","steps":["trace[1548307866] 'agreement among raft nodes before linearized reading' (duration: 298.827159ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:35:50.988678Z","caller":"traceutil/trace.go:171","msg":"trace[433819234] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"602.350138ms","start":"2026-02-17T06:35:50.386323Z","end":"2026-02-17T06:35:50.988673Z","steps":["trace[433819234] 'process raft request' (duration: 601.486954ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:50.988719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:50.386316Z","time spent":"602.380399ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:35:50.989466Z","caller":"traceutil/trace.go:171","msg":"trace[260095762] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"603.101119ms","start":"2026-02-17T06:35:50.386357Z","end":"2026-02-17T06:35:50.989458Z","steps":["trace[260095762] 'process raft request' (duration: 602.007639ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:50.989526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:50.386353Z","time spent":"603.14967ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:35:50.989743Z","caller":"traceutil/trace.go:171","msg":"trace[1562131337] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"602.519412ms","start":"2026-02-17T06:35:50.387217Z","end":"2026-02-17T06:35:50.989736Z","steps":["trace[1562131337] 'process raft request' (duration: 601.179266ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:50.989786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:50.387208Z","time spent":"602.555513ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:35:50.989853Z","caller":"traceutil/trace.go:171","msg":"trace[1108542401] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"549.821841ms","start":"2026-02-17T06:35:50.440022Z","end":"2026-02-17T06:35:50.989844Z","steps":["trace[1108542401] 'process raft request' (duration: 548.397492ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:50.989915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:50.440005Z","time spent":"549.870502ms","remote":"127.0.0.1:34352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:35:52.048344Z","caller":"traceutil/trace.go:171","msg":"trace[1547209592] linearizableReadLoop","detail":"{readStateIndex:793; appliedIndex:792; }","duration":"214.704193ms","start":"2026-02-17T06:35:51.833517Z","end":"2026-02-17T06:35:52.048221Z","steps":["trace[1547209592] 'read index received' (duration: 214.499257ms)","trace[1547209592] 'applied index is now lower than readState.Index' (duration: 203.786µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:35:52.048683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.147645ms","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-17T06:35:52.048727Z","caller":"traceutil/trace.go:171","msg":"trace[1323445077] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:766; }","duration":"215.250718ms","start":"2026-02-17T06:35:51.833466Z","end":"2026-02-17T06:35:52.048716Z","steps":["trace[1323445077] 'agreement among raft nodes before linearized reading' (duration: 215.025491ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:35:52.049392Z","caller":"traceutil/trace.go:171","msg":"trace[538578460] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"901.358101ms","start":"2026-02-17T06:35:51.148006Z","end":"2026-02-17T06:35:52.049364Z","steps":["trace[538578460] 'process raft request' (duration: 900.080086ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:52.049697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:51.147981Z","time spent":"901.598638ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:36:03.172225Z","caller":"traceutil/trace.go:171","msg":"trace[1948777219] transaction","detail":"{read_only:false; response_revision:847; number_of_response:1; }","duration":"113.186757ms","start":"2026-02-17T06:36:03.059022Z","end":"2026-02-17T06:36:03.172208Z","steps":["trace[1948777219] 'process raft request' (duration: 112.56988ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:04.40034Z","caller":"traceutil/trace.go:171","msg":"trace[615402936] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"261.312956ms","start":"2026-02-17T06:36:04.139011Z","end":"2026-02-17T06:36:04.400324Z","steps":["trace[615402936] 'process raft request' (duration: 261.220214ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:04.400706Z","caller":"traceutil/trace.go:171","msg":"trace[1772587748] linearizableReadLoop","detail":"{readStateIndex:882; appliedIndex:882; }","duration":"109.941118ms","start":"2026-02-17T06:36:04.290758Z","end":"2026-02-17T06:36:04.400699Z","steps":["trace[1772587748] 'read index received' (duration: 109.938838ms)","trace[1772587748] 'applied index is now lower than readState.Index' (duration: 1.98µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:04.400802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.039211ms","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-17T06:36:04.400817Z","caller":"traceutil/trace.go:171","msg":"trace[639015568] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:851; }","duration":"110.121713ms","start":"2026-02-17T06:36:04.290691Z","end":"2026-02-17T06:36:04.400813Z","steps":["trace[639015568] 'agreement among raft nodes before linearized reading' (duration: 110.0293ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:04.5802Z","caller":"traceutil/trace.go:171","msg":"trace[141566325] transaction","detail":"{read_only:false; response_revision:852; number_of_response:1; }","duration":"176.035177ms","start":"2026-02-17T06:36:04.404149Z","end":"2026-02-17T06:36:04.580184Z","steps":["trace[141566325] 'process raft request' (duration: 145.99356ms)","trace[141566325] 'compare' (duration: 29.963715ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:04.980418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.035284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:04.98047Z","caller":"traceutil/trace.go:171","msg":"trace[1688204493] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:852; }","duration":"291.126377ms","start":"2026-02-17T06:36:04.689331Z","end":"2026-02-17T06:36:04.980457Z","steps":["trace[1688204493] 'range keys from in-memory index tree' (duration: 290.984932ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:14.810766Z","caller":"traceutil/trace.go:171","msg":"trace[1571522911] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"122.778261ms","start":"2026-02-17T06:36:14.687975Z","end":"2026-02-17T06:36:14.810753Z","steps":["trace[1571522911] 'process raft request' (duration: 122.488933ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:15.512111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.540859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-02-17T06:36:15.512137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.986668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T06:36:15.51216Z","caller":"traceutil/trace.go:171","msg":"trace[1869315010] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:880; }","duration":"384.634962ms","start":"2026-02-17T06:36:15.127515Z","end":"2026-02-17T06:36:15.51215Z","steps":["trace[1869315010] 'count revisions from in-memory index tree' (duration: 384.482778ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:15.512187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:15.127498Z","time spent":"384.683904ms","remote":"127.0.0.1:34692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-02-17T06:36:15.512187Z","caller":"traceutil/trace.go:171","msg":"trace[1027551638] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:880; }","duration":"147.080291ms","start":"2026-02-17T06:36:15.365095Z","end":"2026-02-17T06:36:15.512175Z","steps":["trace[1027551638] 'count revisions from in-memory index tree' (duration: 146.908205ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:15.512436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.113176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-02-17T06:36:15.512451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.310078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-17T06:36:15.512469Z","caller":"traceutil/trace.go:171","msg":"trace[445278847] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:880; }","duration":"256.337109ms","start":"2026-02-17T06:36:15.256127Z","end":"2026-02-17T06:36:15.512464Z","steps":["trace[445278847] 'range keys from in-memory index tree' (duration: 256.243037ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:15.512452Z","caller":"traceutil/trace.go:171","msg":"trace[494762200] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:880; }","duration":"267.129096ms","start":"2026-02-17T06:36:15.245318Z","end":"2026-02-17T06:36:15.512447Z","steps":["trace[494762200] 'range keys from in-memory index tree' (duration: 267.031083ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:15.512538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.164415ms","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-17T06:36:15.512551Z","caller":"traceutil/trace.go:171","msg":"trace[146590845] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:880; }","duration":"292.207447ms","start":"2026-02-17T06:36:15.220339Z","end":"2026-02-17T06:36:15.512546Z","steps":["trace[146590845] 'range keys from in-memory index tree' (duration: 292.077113ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:15.512616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.003021ms","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-17T06:36:15.51264Z","caller":"traceutil/trace.go:171","msg":"trace[1417065537] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:880; }","duration":"288.055062ms","start":"2026-02-17T06:36:15.224581Z","end":"2026-02-17T06:36:15.512636Z","steps":["trace[1417065537] 'range keys from in-memory index tree' (duration: 287.915029ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:15.626033Z","caller":"traceutil/trace.go:171","msg":"trace[595884071] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"109.444244ms","start":"2026-02-17T06:36:15.516571Z","end":"2026-02-17T06:36:15.626015Z","steps":["trace[595884071] 'process raft request' (duration: 109.3213ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:16.208656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.977606ms","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-17T06:36:16.20874Z","caller":"traceutil/trace.go:171","msg":"trace[1921604393] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:881; }","duration":"107.069138ms","start":"2026-02-17T06:36:16.101659Z","end":"2026-02-17T06:36:16.208729Z","steps":["trace[1921604393] 'range keys from in-memory index tree' (duration: 106.966385ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:16.209328Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757018494557416367,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-17T06:36:16.233632Z","caller":"traceutil/trace.go:171","msg":"trace[1074347045] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"716.898352ms","start":"2026-02-17T06:36:15.51672Z","end":"2026-02-17T06:36:16.233618Z","steps":["trace[1074347045] 'process raft request' (duration: 716.627404ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:16.233724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:15.516714Z","time spent":"716.960163ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:36:16.23393Z","caller":"traceutil/trace.go:171","msg":"trace[977582286] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"717.173669ms","start":"2026-02-17T06:36:15.516751Z","end":"2026-02-17T06:36:16.233925Z","steps":["trace[977582286] 'process raft request' (duration: 716.690236ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:16.233959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:15.516748Z","time spent":"717.194561ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:36:16.234062Z","caller":"traceutil/trace.go:171","msg":"trace[2075083639] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"714.27773ms","start":"2026-02-17T06:36:15.519777Z","end":"2026-02-17T06:36:16.234055Z","steps":["trace[2075083639] 'process raft request' (duration: 713.682583ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:16.234087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:15.519763Z","time spent":"714.310881ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:36:16.374629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.125116ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-17T06:36:16.374702Z","caller":"traceutil/trace.go:171","msg":"trace[1696045370] linearizableReadLoop","detail":"{readStateIndex:918; appliedIndex:914; }","duration":"665.411434ms","start":"2026-02-17T06:36:15.709278Z","end":"2026-02-17T06:36:16.374689Z","steps":["trace[1696045370] 'read index received' (duration: 524.02113ms)","trace[1696045370] 'applied index is now lower than readState.Index' (duration: 141.389224ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:16.374753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.468506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:16.374769Z","caller":"traceutil/trace.go:171","msg":"trace[470681554] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:884; }","duration":"665.537398ms","start":"2026-02-17T06:36:15.709226Z","end":"2026-02-17T06:36:16.374763Z","steps":["trace[470681554] 'agreement among raft nodes before linearized reading' (duration: 665.495147ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:16.374793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:15.709188Z","time spent":"665.599559ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T06:36:18.014672Z","caller":"traceutil/trace.go:171","msg":"trace[1124955400] linearizableReadLoop","detail":"{readStateIndex:920; appliedIndex:919; }","duration":"328.662011ms","start":"2026-02-17T06:36:17.685993Z","end":"2026-02-17T06:36:18.014655Z","steps":["trace[1124955400] 'read index received' (duration: 328.521947ms)","trace[1124955400] 'applied index is now lower than readState.Index' (duration: 139.394µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:18.01478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.767263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:18.014801Z","caller":"traceutil/trace.go:171","msg":"trace[295978444] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:886; }","duration":"328.827135ms","start":"2026-02-17T06:36:17.685967Z","end":"2026-02-17T06:36:18.014794Z","steps":["trace[295978444] 'agreement among raft nodes before linearized reading' (duration: 328.753273ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:18.014824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:17.685954Z","time spent":"328.865226ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T06:36:18.01506Z","caller":"traceutil/trace.go:171","msg":"trace[1535646532] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"384.292553ms","start":"2026-02-17T06:36:17.630761Z","end":"2026-02-17T06:36:18.015053Z","steps":["trace[1535646532] 'process raft request' (duration: 383.801659ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:18.015131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:17.630751Z","time spent":"384.325513ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:36:23.603463Z","caller":"traceutil/trace.go:171","msg":"trace[1540492708] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"590.253195ms","start":"2026-02-17T06:36:23.013192Z","end":"2026-02-17T06:36:23.603446Z","steps":["trace[1540492708] 'process raft request' (duration: 590.145082ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:23.603565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:23.01317Z","time spent":"590.340587ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:36:24.608963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.086266ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T06:36:24.609059Z","caller":"traceutil/trace.go:171","msg":"trace[1457944449] linearizableReadLoop","detail":"{readStateIndex:945; appliedIndex:944; }","duration":"205.86469ms","start":"2026-02-17T06:36:24.403179Z","end":"2026-02-17T06:36:24.609043Z","steps":["trace[1457944449] 'read index received' (duration: 60.582069ms)","trace[1457944449] 'applied index is now lower than readState.Index' (duration: 145.281541ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:36:24.609151Z","caller":"traceutil/trace.go:171","msg":"trace[1509224624] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"211.613437ms","start":"2026-02-17T06:36:24.397528Z","end":"2026-02-17T06:36:24.609141Z","steps":["trace[1509224624] 'process raft request' (duration: 66.250795ms)","trace[1509224624] 'compare' (duration: 144.989902ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:24.609424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.194678ms","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-17T06:36:24.609498Z","caller":"traceutil/trace.go:171","msg":"trace[854815915] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:910; }","duration":"206.286641ms","start":"2026-02-17T06:36:24.403197Z","end":"2026-02-17T06:36:24.609483Z","steps":["trace[854815915] 'agreement among raft nodes before linearized reading' (duration: 206.059655ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:24.609601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.409225ms","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-17T06:36:24.609637Z","caller":"traceutil/trace.go:171","msg":"trace[1436756508] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:910; }","duration":"206.467226ms","start":"2026-02-17T06:36:24.403159Z","end":"2026-02-17T06:36:24.609626Z","steps":["trace[1436756508] 'agreement among raft nodes before linearized reading' (duration: 206.334032ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:24.609703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.78436ms","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-17T06:36:24.60973Z","caller":"traceutil/trace.go:171","msg":"trace[1386649332] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:910; }","duration":"200.82433ms","start":"2026-02-17T06:36:24.408898Z","end":"2026-02-17T06:36:24.609722Z","steps":["trace[1386649332] 'agreement among raft nodes before linearized reading' (duration: 200.749108ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:24.927595Z","caller":"traceutil/trace.go:171","msg":"trace[1164162367] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"310.532482ms","start":"2026-02-17T06:36:24.617048Z","end":"2026-02-17T06:36:24.927581Z","steps":["trace[1164162367] 'process raft request' (duration: 310.513121ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:24.927689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:24.61704Z","time spent":"310.597593ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:36:24.927829Z","caller":"traceutil/trace.go:171","msg":"trace[634946965] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"313.312638ms","start":"2026-02-17T06:36:24.614512Z","end":"2026-02-17T06:36:24.927824Z","steps":["trace[634946965] 'process raft request' (duration: 312.948188ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:24.927856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:24.61449Z","time spent":"313.350859ms","remote":"127.0.0.1:34396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":823,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T06:36:24.927978Z","caller":"traceutil/trace.go:171","msg":"trace[2048131941] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"312.269279ms","start":"2026-02-17T06:36:24.615704Z","end":"2026-02-17T06:36:24.927974Z","steps":["trace[2048131941] 'process raft request' (duration: 311.824897ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:24.928005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:24.615696Z","time spent":"312.29378ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:36:25.327703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.18355ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T06:36:25.327776Z","caller":"traceutil/trace.go:171","msg":"trace[2001801775] linearizableReadLoop","detail":"{readStateIndex:950; appliedIndex:949; }","duration":"453.90971ms","start":"2026-02-17T06:36:24.873853Z","end":"2026-02-17T06:36:25.327763Z","steps":["trace[2001801775] 'read index received' (duration: 54.346317ms)","trace[2001801775] 'applied index is now lower than readState.Index' (duration: 399.562663ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:25.327884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.027703ms","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-17T06:36:25.327899Z","caller":"traceutil/trace.go:171","msg":"trace[678946750] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:915; }","duration":"454.069754ms","start":"2026-02-17T06:36:24.873823Z","end":"2026-02-17T06:36:25.327893Z","steps":["trace[678946750] 'agreement among raft nodes before linearized reading' (duration: 453.971252ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:25.327915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:24.873811Z","time spent":"454.099585ms","remote":"127.0.0.1:34550","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-17T06:36:25.328092Z","caller":"traceutil/trace.go:171","msg":"trace[35661776] transaction","detail":"{read_only:false; response_revision:915; number_of_response:1; }","duration":"456.895032ms","start":"2026-02-17T06:36:24.871191Z","end":"2026-02-17T06:36:25.328086Z","steps":["trace[35661776] 'process raft request' (duration: 263.263579ms)","trace[35661776] 'compare' (duration: 193.117048ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:25.328122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:24.871168Z","time spent":"456.938903ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:36:26.190807Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757018494557416445,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T06:36:26.531106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.721456ms","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-17T06:36:26.531324Z","caller":"traceutil/trace.go:171","msg":"trace[1994187002] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:916; }","duration":"428.843059ms","start":"2026-02-17T06:36:26.102365Z","end":"2026-02-17T06:36:26.531208Z","steps":["trace[1994187002] 'range keys from in-memory index tree' (duration: 428.707955ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:26.653068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.710877ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-17T06:36:26.653194Z","caller":"traceutil/trace.go:171","msg":"trace[2138782315] linearizableReadLoop","detail":"{readStateIndex:952; appliedIndex:951; }","duration":"962.812334ms","start":"2026-02-17T06:36:25.690365Z","end":"2026-02-17T06:36:26.653177Z","steps":["trace[2138782315] 'read index received' (duration: 838.823499ms)","trace[2138782315] 'applied index is now lower than readState.Index' (duration: 123.987485ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:26.653513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.482087ms","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-17T06:36:26.653554Z","caller":"traceutil/trace.go:171","msg":"trace[1918352085] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:916; }","duration":"555.57577ms","start":"2026-02-17T06:36:26.097965Z","end":"2026-02-17T06:36:26.653541Z","steps":["trace[1918352085] 'agreement among raft nodes before linearized reading' (duration: 555.433556ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:26.653589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:26.097935Z","time spent":"555.646641ms","remote":"127.0.0.1:34550","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-17T06:36:26.653785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"963.428891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:26.653818Z","caller":"traceutil/trace.go:171","msg":"trace[568013521] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:916; }","duration":"963.496082ms","start":"2026-02-17T06:36:25.690313Z","end":"2026-02-17T06:36:26.653809Z","steps":["trace[568013521] 'agreement among raft nodes before linearized reading' (duration: 963.450721ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:26.653848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:25.690294Z","time spent":"963.548384ms","remote":"127.0.0.1:34322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T06:36:26.808947Z","caller":"traceutil/trace.go:171","msg":"trace[1541381243] linearizableReadLoop","detail":"{readStateIndex:953; appliedIndex:952; }","duration":"130.791662ms","start":"2026-02-17T06:36:26.678138Z","end":"2026-02-17T06:36:26.808929Z","steps":["trace[1541381243] 'read index received' (duration: 130.610657ms)","trace[1541381243] 'applied index is now lower than readState.Index' (duration: 180.375µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:26.809091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.935626ms","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-17T06:36:26.809115Z","caller":"traceutil/trace.go:171","msg":"trace[2039796152] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:917; }","duration":"131.001317ms","start":"2026-02-17T06:36:26.678108Z","end":"2026-02-17T06:36:26.80911Z","steps":["trace[2039796152] 'agreement among raft nodes before linearized reading' (duration: 130.887084ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:26.809315Z","caller":"traceutil/trace.go:171","msg":"trace[1870136600] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"152.740656ms","start":"2026-02-17T06:36:26.656568Z","end":"2026-02-17T06:36:26.809308Z","steps":["trace[1870136600] 'process raft request' (duration: 152.226192ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:27.219193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.993313ms","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-17T06:36:27.219246Z","caller":"traceutil/trace.go:171","msg":"trace[1436242070] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:918; }","duration":"287.055985ms","start":"2026-02-17T06:36:26.932178Z","end":"2026-02-17T06:36:27.219234Z","steps":["trace[1436242070] 'range keys from in-memory index tree' (duration: 286.88118ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:27.219424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.610262ms","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-17T06:36:27.219451Z","caller":"traceutil/trace.go:171","msg":"trace[677108560] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:918; }","duration":"286.648734ms","start":"2026-02-17T06:36:26.932797Z","end":"2026-02-17T06:36:27.219445Z","steps":["trace[677108560] 'range keys from in-memory index tree' (duration: 286.562411ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:27.21958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.453874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:27.219604Z","caller":"traceutil/trace.go:171","msg":"trace[1943974145] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:918; }","duration":"174.503145ms","start":"2026-02-17T06:36:27.045095Z","end":"2026-02-17T06:36:27.219598Z","steps":["trace[1943974145] 'range keys from in-memory index tree' (duration: 174.408562ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:27.87437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.972462ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T06:36:27.874482Z","caller":"traceutil/trace.go:171","msg":"trace[362324049] linearizableReadLoop","detail":"{readStateIndex:956; appliedIndex:955; }","duration":"488.381199ms","start":"2026-02-17T06:36:27.386066Z","end":"2026-02-17T06:36:27.874447Z","steps":["trace[362324049] 'read index received' (duration: 39.941µs)","trace[362324049] 'applied index is now lower than readState.Index' (duration: 488.339818ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:36:27.87471Z","caller":"traceutil/trace.go:171","msg":"trace[662428311] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"649.899807ms","start":"2026-02-17T06:36:27.224797Z","end":"2026-02-17T06:36:27.874697Z","steps":["trace[662428311] 'process raft request' (duration: 159.366279ms)","trace[662428311] 'compare' (duration: 489.601872ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:27.87478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:27.224789Z","time spent":"649.956208ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:36:27.875583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.756407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:27.875894Z","caller":"traceutil/trace.go:171","msg":"trace[11214277] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:920; }","duration":"368.081616ms","start":"2026-02-17T06:36:27.507782Z","end":"2026-02-17T06:36:27.875864Z","steps":["trace[11214277] 'agreement among raft nodes before linearized reading' (duration: 367.762407ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:27.875946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:27.507767Z","time spent":"368.163988ms","remote":"127.0.0.1:34412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-02-17T06:36:27.876115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.457395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:27.876151Z","caller":"traceutil/trace.go:171","msg":"trace[385369925] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:920; }","duration":"186.513246ms","start":"2026-02-17T06:36:27.689629Z","end":"2026-02-17T06:36:27.876143Z","steps":["trace[385369925] 'agreement among raft nodes before linearized reading' (duration: 186.461164ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:27.876302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.773256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:27.876337Z","caller":"traceutil/trace.go:171","msg":"trace[480884806] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:920; }","duration":"189.843908ms","start":"2026-02-17T06:36:27.686484Z","end":"2026-02-17T06:36:27.876328Z","steps":["trace[480884806] 'agreement among raft nodes before linearized reading' (duration: 189.793106ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:27.876492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.864089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:27.876525Z","caller":"traceutil/trace.go:171","msg":"trace[1753992715] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:920; }","duration":"278.931811ms","start":"2026-02-17T06:36:27.597585Z","end":"2026-02-17T06:36:27.876517Z","steps":["trace[1753992715] 'agreement among raft nodes before linearized reading' (duration: 278.88208ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:27.878067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.991028ms","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-17T06:36:27.878114Z","caller":"traceutil/trace.go:171","msg":"trace[555966246] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:920; }","duration":"492.076261ms","start":"2026-02-17T06:36:27.386027Z","end":"2026-02-17T06:36:27.878103Z","steps":["trace[555966246] 'agreement among raft nodes before linearized reading' (duration: 488.908584ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:27.878159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:27.386008Z","time spent":"492.131362ms","remote":"127.0.0.1:34550","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-17T06:36:28.145248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.280617ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T06:36:28.145326Z","caller":"traceutil/trace.go:171","msg":"trace[1005017227] linearizableReadLoop","detail":"{readStateIndex:957; appliedIndex:956; }","duration":"260.062261ms","start":"2026-02-17T06:36:27.885252Z","end":"2026-02-17T06:36:28.145314Z","steps":["trace[1005017227] 'read index received' (duration: 92.653381ms)","trace[1005017227] 'applied index is now lower than readState.Index' (duration: 167.40578ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:28.145643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.38685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T06:36:28.145661Z","caller":"traceutil/trace.go:171","msg":"trace[124640494] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:921; }","duration":"260.424282ms","start":"2026-02-17T06:36:27.885231Z","end":"2026-02-17T06:36:28.145655Z","steps":["trace[124640494] 'agreement among raft nodes before linearized reading' (duration: 260.34705ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:28.14578Z","caller":"traceutil/trace.go:171","msg":"trace[1370638802] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"264.456473ms","start":"2026-02-17T06:36:27.881315Z","end":"2026-02-17T06:36:28.145772Z","steps":["trace[1370638802] 'process raft request' (duration: 96.58953ms)","trace[1370638802] 'compare' (duration: 167.015999ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:36:38.514176Z","caller":"traceutil/trace.go:171","msg":"trace[1740561336] linearizableReadLoop","detail":"{readStateIndex:1021; appliedIndex:1020; }","duration":"241.679985ms","start":"2026-02-17T06:36:38.272479Z","end":"2026-02-17T06:36:38.514159Z","steps":["trace[1740561336] 'read index received' (duration: 241.532321ms)","trace[1740561336] 'applied index is now lower than readState.Index' (duration: 146.964µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:38.514427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.920661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-02-17T06:36:38.514457Z","caller":"traceutil/trace.go:171","msg":"trace[426602245] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:983; }","duration":"242.000794ms","start":"2026-02-17T06:36:38.272447Z","end":"2026-02-17T06:36:38.514447Z","steps":["trace[426602245] 'agreement among raft nodes before linearized reading' (duration: 241.834459ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:38.514699Z","caller":"traceutil/trace.go:171","msg":"trace[1895722760] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"327.340384ms","start":"2026-02-17T06:36:38.187351Z","end":"2026-02-17T06:36:38.514692Z","steps":["trace[1895722760] 'process raft request' (duration: 326.705707ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:38.515164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:38.187336Z","time spent":"327.385455ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:36:38.689519Z","caller":"traceutil/trace.go:171","msg":"trace[1465138918] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"169.817846ms","start":"2026-02-17T06:36:38.519677Z","end":"2026-02-17T06:36:38.689495Z","steps":["trace[1465138918] 'process raft request' (duration: 151.934284ms)","trace[1465138918] 'compare' (duration: 17.06742ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:39.182892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.806688ms","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-17T06:36:39.182944Z","caller":"traceutil/trace.go:171","msg":"trace[695160389] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:984; }","duration":"335.90087ms","start":"2026-02-17T06:36:38.84703Z","end":"2026-02-17T06:36:39.182931Z","steps":["trace[695160389] 'range keys from in-memory index tree' (duration: 335.668264ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:39.182972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:38.847012Z","time spent":"335.952461ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T06:36:39.183262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.909986ms","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-17T06:36:39.183284Z","caller":"traceutil/trace.go:171","msg":"trace[1290029603] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:984; }","duration":"304.954098ms","start":"2026-02-17T06:36:38.878323Z","end":"2026-02-17T06:36:39.183277Z","steps":["trace[1290029603] 'range keys from in-memory index tree' (duration: 304.823934ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:39.1833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:38.878311Z","time spent":"304.984998ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-17T06:37:27.517249Z","caller":"traceutil/trace.go:171","msg":"trace[1118826436] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"119.265079ms","start":"2026-02-17T06:37:27.397963Z","end":"2026-02-17T06:37:27.517229Z","steps":["trace[1118826436] 'process raft request' (duration: 40.25543ms)","trace[1118826436] 'compare' (duration: 78.63868ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:38:00.49727Z","caller":"traceutil/trace.go:171","msg":"trace[559982136] linearizableReadLoop","detail":"{readStateIndex:1389; appliedIndex:1388; }","duration":"137.551366ms","start":"2026-02-17T06:38:00.359697Z","end":"2026-02-17T06:38:00.497248Z","steps":["trace[559982136] 'read index received' (duration: 137.386951ms)","trace[559982136] 'applied index is now lower than readState.Index' (duration: 163.525µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:38:00.498862Z","caller":"traceutil/trace.go:171","msg":"trace[762605074] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"149.032208ms","start":"2026-02-17T06:38:00.349793Z","end":"2026-02-17T06:38:00.498825Z","steps":["trace[762605074] 'process raft request' (duration: 147.343334ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:38:00.498529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.050169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.38\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-17T06:38:00.499219Z","caller":"traceutil/trace.go:171","msg":"trace[1435941992] range","detail":"{range_begin:/registry/masterleases/199.204.45.38; range_end:; response_count:1; response_revision:1335; }","duration":"139.520497ms","start":"2026-02-17T06:38:00.359684Z","end":"2026-02-17T06:38:00.499205Z","steps":["trace[1435941992] 'agreement among raft nodes before linearized reading' (duration: 137.928365ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:38:06.153712Z","caller":"traceutil/trace.go:171","msg":"trace[2028062061] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"154.232885ms","start":"2026-02-17T06:38:05.999456Z","end":"2026-02-17T06:38:06.153689Z","steps":["trace[2028062061] 'process raft request' (duration: 72.815284ms)","trace[2028062061] 'compare' (duration: 81.174204ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:38:12.260878Z","caller":"traceutil/trace.go:171","msg":"trace[1794107678] transaction","detail":"{read_only:false; response_revision:1382; number_of_response:1; }","duration":"188.768752ms","start":"2026-02-17T06:38:12.072087Z","end":"2026-02-17T06:38:12.260856Z","steps":["trace[1794107678] 'process raft request' (duration: 188.283529ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:39:05.172603Z","caller":"traceutil/trace.go:171","msg":"trace[1937555537] transaction","detail":"{read_only:false; response_revision:1597; number_of_response:1; }","duration":"121.324703ms","start":"2026-02-17T06:39:05.051232Z","end":"2026-02-17T06:39:05.172557Z","steps":["trace[1937555537] 'process raft request' (duration: 121.135008ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:39:05.316231Z","caller":"traceutil/trace.go:171","msg":"trace[1173894881] transaction","detail":"{read_only:false; response_revision:1598; number_of_response:1; }","duration":"123.560553ms","start":"2026-02-17T06:39:05.192644Z","end":"2026-02-17T06:39:05.316204Z","steps":["trace[1173894881] 'process raft request' (duration: 96.572545ms)","trace[1173894881] 'compare' (duration: 26.871285ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:39:57.822643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.322846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:39:57.822715Z","caller":"traceutil/trace.go:171","msg":"trace[1123135208] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1842; }","duration":"186.45982ms","start":"2026-02-17T06:39:57.636241Z","end":"2026-02-17T06:39:57.822701Z","steps":["trace[1123135208] 'count revisions from in-memory index tree' (duration: 186.255494ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:39:57.823757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.787394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-02-17T06:39:57.823829Z","caller":"traceutil/trace.go:171","msg":"trace[972161569] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1842; }","duration":"171.932428ms","start":"2026-02-17T06:39:57.651879Z","end":"2026-02-17T06:39:57.823811Z","steps":["trace[972161569] 'range keys from in-memory index tree' (duration: 171.600299ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:39:57.824045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.443434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:39:57.824093Z","caller":"traceutil/trace.go:171","msg":"trace[390880939] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1842; }","duration":"135.520826ms","start":"2026-02-17T06:39:57.688562Z","end":"2026-02-17T06:39:57.824083Z","steps":["trace[390880939] 'range keys from in-memory index tree' (duration: 135.394863ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:39:58.191187Z","caller":"traceutil/trace.go:171","msg":"trace[506333540] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"139.070871ms","start":"2026-02-17T06:39:58.05209Z","end":"2026-02-17T06:39:58.191161Z","steps":["trace[506333540] 'process raft request' (duration: 138.919297ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:39:58.676648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.833066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-02-17T06:39:58.676715Z","caller":"traceutil/trace.go:171","msg":"trace[1673394615] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1846; }","duration":"108.946969ms","start":"2026-02-17T06:39:58.567752Z","end":"2026-02-17T06:39:58.676699Z","steps":["trace[1673394615] 'range keys from in-memory index tree' (duration: 108.660351ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:40:04.112584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.490865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:536"} {"level":"info","ts":"2026-02-17T06:40:04.112652Z","caller":"traceutil/trace.go:171","msg":"trace[632650949] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:1874; }","duration":"116.618528ms","start":"2026-02-17T06:40:03.996019Z","end":"2026-02-17T06:40:04.112638Z","steps":["trace[632650949] 'range keys from in-memory index tree' (duration: 116.375522ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:40:19.558714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.11023ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T06:40:19.55979Z","caller":"traceutil/trace.go:171","msg":"trace[1114922667] linearizableReadLoop","detail":"{readStateIndex:2022; appliedIndex:2021; }","duration":"116.950567ms","start":"2026-02-17T06:40:19.442823Z","end":"2026-02-17T06:40:19.559774Z","steps":["trace[1114922667] 'read index received' (duration: 24.711µs)","trace[1114922667] 'applied index is now lower than readState.Index' (duration: 116.924166ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:40:19.559886Z","caller":"traceutil/trace.go:171","msg":"trace[115606305] transaction","detail":"{read_only:false; response_revision:1939; number_of_response:1; }","duration":"231.192042ms","start":"2026-02-17T06:40:19.32868Z","end":"2026-02-17T06:40:19.559872Z","steps":["trace[115606305] 'process raft request' (duration: 101.862649ms)","trace[115606305] 'compare' (duration: 127.972227ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:40:19.559997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.172213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/cilium-config\" ","response":"range_response_count:1 size:6534"} {"level":"info","ts":"2026-02-17T06:40:19.560614Z","caller":"traceutil/trace.go:171","msg":"trace[1240697960] range","detail":"{range_begin:/registry/configmaps/kube-system/cilium-config; range_end:; response_count:1; response_revision:1939; }","duration":"117.81716ms","start":"2026-02-17T06:40:19.442787Z","end":"2026-02-17T06:40:19.560604Z","steps":["trace[1240697960] 'agreement among raft nodes before linearized reading' (duration: 117.145012ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:40:19.818974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.655749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/kube-public/\" range_end:\"/registry/persistentvolumeclaims/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:40:19.819048Z","caller":"traceutil/trace.go:171","msg":"trace[938284878] range","detail":"{range_begin:/registry/persistentvolumeclaims/kube-public/; range_end:/registry/persistentvolumeclaims/kube-public0; response_count:0; response_revision:1939; }","duration":"105.768043ms","start":"2026-02-17T06:40:19.713261Z","end":"2026-02-17T06:40:19.819029Z","steps":["trace[938284878] 'range keys from in-memory index tree' (duration: 105.538436ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:40:19.819145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.124179ms","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-17T06:40:19.819251Z","caller":"traceutil/trace.go:171","msg":"trace[564265621] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1939; }","duration":"131.300584ms","start":"2026-02-17T06:40:19.687924Z","end":"2026-02-17T06:40:19.819225Z","steps":["trace[564265621] 'range keys from in-memory index tree' (duration: 130.907083ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:40:19.823464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.769201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/ceph-csi-encryption-kms-config\" ","response":"range_response_count:1 size:811"} {"level":"info","ts":"2026-02-17T06:40:19.823502Z","caller":"traceutil/trace.go:171","msg":"trace[382837656] range","detail":"{range_begin:/registry/configmaps/kube-system/ceph-csi-encryption-kms-config; range_end:; response_count:1; response_revision:1939; }","duration":"146.840913ms","start":"2026-02-17T06:40:19.676648Z","end":"2026-02-17T06:40:19.823489Z","steps":["trace[382837656] 'range keys from in-memory index tree' (duration: 146.683538ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:40:19.823597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.60228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:40:19.823627Z","caller":"traceutil/trace.go:171","msg":"trace[1147470995] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1939; }","duration":"137.656721ms","start":"2026-02-17T06:40:19.685962Z","end":"2026-02-17T06:40:19.823619Z","steps":["trace[1147470995] 'range keys from in-memory index tree' (duration: 137.544808ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:40:24.781199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.141055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/extension-apiserver-authentication-reader\" ","response":"range_response_count:1 size:671"} {"level":"info","ts":"2026-02-17T06:40:24.781285Z","caller":"traceutil/trace.go:171","msg":"trace[2011981504] range","detail":"{range_begin:/registry/roles/kube-system/extension-apiserver-authentication-reader; range_end:; response_count:1; response_revision:1960; }","duration":"100.263697ms","start":"2026-02-17T06:40:24.681003Z","end":"2026-02-17T06:40:24.781267Z","steps":["trace[2011981504] 'range keys from in-memory index tree' (duration: 100.065083ms)"],"step_count":1}