{"level":"warn","ts":"2026-02-23T20:10:59.117529Z","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-23T20:10:59.117615Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.195:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.195:2380","--initial-cluster=instance=https://162.253.55.195:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.195:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.195: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-23T20:10:59.117682Z","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-23T20:10:59.117693Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.195:2380"]} {"level":"info","ts":"2026-02-23T20:10:59.117713Z","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-23T20:10:59.118329Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"]} {"level":"info","ts":"2026-02-23T20:10:59.1184Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.195: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-23T20:10:59.122293Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.641285ms"} {"level":"info","ts":"2026-02-23T20:10:59.128117Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b66d12fd59101739","cluster-id":"a64a525934ce8379"} {"level":"info","ts":"2026-02-23T20:10:59.128186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=()"} {"level":"info","ts":"2026-02-23T20:10:59.12821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 0"} {"level":"info","ts":"2026-02-23T20:10:59.128228Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b66d12fd59101739 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-23T20:10:59.12824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 1"} {"level":"info","ts":"2026-02-23T20:10:59.128276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"} {"level":"warn","ts":"2026-02-23T20:10:59.137112Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-23T20:10:59.138551Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-23T20:10:59.139705Z","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-23T20:10:59.142522Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b66d12fd59101739","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-23T20:10:59.142705Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b66d12fd59101739","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-23T20:10:59.142727Z","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-23T20:10:59.143024Z","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-23T20:10:59.143047Z","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-23T20:10:59.146191Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"} {"level":"info","ts":"2026-02-23T20:10:59.146534Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","added-peer-id":"b66d12fd59101739","added-peer-peer-urls":["https://162.253.55.195:2380"]} {"level":"info","ts":"2026-02-23T20:10:59.147586Z","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-23T20:10:59.147752Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.195:2380"} {"level":"info","ts":"2026-02-23T20:10:59.147806Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.195:2380"} {"level":"info","ts":"2026-02-23T20:10:59.148446Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b66d12fd59101739","initial-advertise-peer-urls":["https://162.253.55.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-23T20:10:59.148476Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-23T20:10:59.829361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 is starting a new election at term 1"} {"level":"info","ts":"2026-02-23T20:10:59.829416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-23T20:10:59.829442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgPreVoteResp from b66d12fd59101739 at term 1"} {"level":"info","ts":"2026-02-23T20:10:59.829455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became candidate at term 2"} {"level":"info","ts":"2026-02-23T20:10:59.82946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgVoteResp from b66d12fd59101739 at term 2"} {"level":"info","ts":"2026-02-23T20:10:59.829468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became leader at term 2"} {"level":"info","ts":"2026-02-23T20:10:59.829475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b66d12fd59101739 elected leader b66d12fd59101739 at term 2"} {"level":"info","ts":"2026-02-23T20:10:59.830366Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b66d12fd59101739","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.195:2379]}","request-path":"/0/members/b66d12fd59101739/attributes","cluster-id":"a64a525934ce8379","publish-timeout":"7s"} {"level":"info","ts":"2026-02-23T20:10:59.830391Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-23T20:10:59.830641Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-23T20:10:59.83072Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-23T20:10:59.832384Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.195:2379"} {"level":"info","ts":"2026-02-23T20:10:59.832851Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-23T20:10:59.832942Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-23T20:10:59.833481Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","cluster-version":"3.5"} {"level":"info","ts":"2026-02-23T20:10:59.833532Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-23T20:10:59.833545Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-23T20:10:59.833765Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-23T20:11:37.118504Z","caller":"traceutil/trace.go:171","msg":"trace[1816039453] linearizableReadLoop","detail":"{readStateIndex:546; appliedIndex:545; }","duration":"233.323784ms","start":"2026-02-23T20:11:36.885152Z","end":"2026-02-23T20:11:37.118475Z","steps":["trace[1816039453] 'read index received' (duration: 233.038557ms)","trace[1816039453] 'applied index is now lower than readState.Index' (duration: 283.807µs)"],"step_count":2} {"level":"info","ts":"2026-02-23T20:11:37.118582Z","caller":"traceutil/trace.go:171","msg":"trace[1085837214] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"439.048115ms","start":"2026-02-23T20:11:36.679507Z","end":"2026-02-23T20:11:37.118555Z","steps":["trace[1085837214] 'process raft request' (duration: 438.794738ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:11:37.118716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.49627ms","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-23T20:11:37.118785Z","caller":"traceutil/trace.go:171","msg":"trace[1013941367] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:528; }","duration":"233.683684ms","start":"2026-02-23T20:11:36.885089Z","end":"2026-02-23T20:11:37.118773Z","steps":["trace[1013941367] 'agreement among raft nodes before linearized reading' (duration: 233.51873ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:11:37.119141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-23T20:11:36.679492Z","time spent":"439.162297ms","remote":"127.0.0.1:58264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-23T20:11:37.63318Z","caller":"traceutil/trace.go:171","msg":"trace[2076038683] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"200.094632ms","start":"2026-02-23T20:11:37.433061Z","end":"2026-02-23T20:11:37.633155Z","steps":["trace[2076038683] 'process raft request' (duration: 199.912677ms)"],"step_count":1} {"level":"info","ts":"2026-02-23T20:11:37.995398Z","caller":"traceutil/trace.go:171","msg":"trace[7102975] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"357.965902ms","start":"2026-02-23T20:11:37.6374Z","end":"2026-02-23T20:11:37.995366Z","steps":["trace[7102975] 'process raft request' (duration: 357.714145ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:11:37.995544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-23T20:11:37.637375Z","time spent":"358.093806ms","remote":"127.0.0.1:58264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-23T20:11:38.921616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"770.210563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tnt9p\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-23T20:11:38.921698Z","caller":"traceutil/trace.go:171","msg":"trace[582938560] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tnt9p; range_end:; response_count:1; response_revision:534; }","duration":"770.336806ms","start":"2026-02-23T20:11:38.151343Z","end":"2026-02-23T20:11:38.92168Z","steps":["trace[582938560] 'range keys from in-memory index tree' (duration: 770.130631ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:11:38.921766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-23T20:11:38.151325Z","time spent":"770.431658ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16680,"request content":"key:\"/registry/pods/kube-system/cilium-tnt9p\" "} {"level":"warn","ts":"2026-02-23T20:11:39.015587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.314802ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"warn","ts":"2026-02-23T20:11:58.626957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.601127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-23T20:11:58.627061Z","caller":"traceutil/trace.go:171","msg":"trace[1933259924] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:721; }","duration":"677.72026ms","start":"2026-02-23T20:11:57.949319Z","end":"2026-02-23T20:11:58.627039Z","steps":["trace[1933259924] 'range keys from in-memory index tree' (duration: 677.532145ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:11:58.627098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-23T20:11:57.94925Z","time spent":"677.839043ms","remote":"127.0.0.1:57966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-23T20:11:58.627308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.583997ms","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-23T20:11:58.62741Z","caller":"traceutil/trace.go:171","msg":"trace[1610001363] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:721; }","duration":"504.745742ms","start":"2026-02-23T20:11:58.12264Z","end":"2026-02-23T20:11:58.627386Z","steps":["trace[1610001363] 'range keys from in-memory index tree' (duration: 504.365172ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:11:58.627466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-23T20:11:58.122615Z","time spent":"504.840614ms","remote":"127.0.0.1:58264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-23T20:11:59.171576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.684582ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-23T20:11:59.172387Z","caller":"traceutil/trace.go:171","msg":"trace[1256070249] linearizableReadLoop","detail":"{readStateIndex:748; appliedIndex:746; }","duration":"220.721054ms","start":"2026-02-23T20:11:58.95161Z","end":"2026-02-23T20:11:59.172331Z","steps":["trace[1256070249] 'read index received' (duration: 173.40736ms)","trace[1256070249] 'applied index is now lower than readState.Index' (duration: 47.309964ms)"],"step_count":2} {"level":"info","ts":"2026-02-23T20:11:59.172448Z","caller":"traceutil/trace.go:171","msg":"trace[497302686] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"540.999786ms","start":"2026-02-23T20:11:58.631402Z","end":"2026-02-23T20:11:59.172401Z","steps":["trace[497302686] 'process raft request' (duration: 540.297177ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:11:59.172668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-23T20:11:58.631356Z","time spent":"541.18572ms","remote":"127.0.0.1:58264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-23T20:11:59.255124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.49163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-23T20:11:59.255236Z","caller":"traceutil/trace.go:171","msg":"trace[2083744681] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:722; }","duration":"303.643704ms","start":"2026-02-23T20:11:58.951561Z","end":"2026-02-23T20:11:59.255205Z","steps":["trace[2083744681] 'agreement among raft nodes before linearized reading' (duration: 220.922319ms)","trace[2083744681] 'range keys from in-memory index tree' (duration: 82.568381ms)"],"step_count":2} {"level":"warn","ts":"2026-02-23T20:11:59.255282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-23T20:11:58.951535Z","time spent":"303.737387ms","remote":"127.0.0.1:57964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-23T20:11:59.255653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.904033ms","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-23T20:11:59.255736Z","caller":"traceutil/trace.go:171","msg":"trace[842290041] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:722; }","duration":"109.54018ms","start":"2026-02-23T20:11:59.146173Z","end":"2026-02-23T20:11:59.255714Z","steps":["trace[842290041] 'agreement among raft nodes before linearized reading' (duration: 26.360913ms)","trace[842290041] 'range keys from in-memory index tree' (duration: 82.489249ms)"],"step_count":2} {"level":"warn","ts":"2026-02-23T20:11:59.782563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.343143ms","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-23T20:11:59.782703Z","caller":"traceutil/trace.go:171","msg":"trace[1060863360] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:725; }","duration":"220.547239ms","start":"2026-02-23T20:11:59.562138Z","end":"2026-02-23T20:11:59.782685Z","steps":["trace[1060863360] 'range keys from in-memory index tree' (duration: 220.286302ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:12:27.874341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.203697ms","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-23T20:12:27.87447Z","caller":"traceutil/trace.go:171","msg":"trace[1115835041] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:809; }","duration":"277.400433ms","start":"2026-02-23T20:12:27.597044Z","end":"2026-02-23T20:12:27.874445Z","steps":["trace[1115835041] 'range keys from in-memory index tree' (duration: 276.89746ms)"],"step_count":1} {"level":"info","ts":"2026-02-23T20:12:28.715791Z","caller":"traceutil/trace.go:171","msg":"trace[402734910] linearizableReadLoop","detail":"{readStateIndex:844; appliedIndex:843; }","duration":"149.805438ms","start":"2026-02-23T20:12:28.565957Z","end":"2026-02-23T20:12:28.715762Z","steps":["trace[402734910] 'read index received' (duration: 135.390015ms)","trace[402734910] 'applied index is now lower than readState.Index' (duration: 14.413683ms)"],"step_count":2} {"level":"warn","ts":"2026-02-23T20:12:28.715942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.959063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-23T20:12:28.715973Z","caller":"traceutil/trace.go:171","msg":"trace[349511183] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:811; }","duration":"150.072585ms","start":"2026-02-23T20:12:28.565891Z","end":"2026-02-23T20:12:28.715963Z","steps":["trace[349511183] 'agreement among raft nodes before linearized reading' (duration: 149.974993ms)"],"step_count":1} {"level":"info","ts":"2026-02-23T20:12:40.112362Z","caller":"traceutil/trace.go:171","msg":"trace[544556484] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"164.825397ms","start":"2026-02-23T20:12:39.947505Z","end":"2026-02-23T20:12:40.112331Z","steps":["trace[544556484] 'process raft request' (duration: 164.623922ms)"],"step_count":1} {"level":"info","ts":"2026-02-23T20:12:41.991585Z","caller":"traceutil/trace.go:171","msg":"trace[1285322733] linearizableReadLoop","detail":"{readStateIndex:933; appliedIndex:932; }","duration":"420.775795ms","start":"2026-02-23T20:12:41.570777Z","end":"2026-02-23T20:12:41.991553Z","steps":["trace[1285322733] 'read index received' (duration: 420.635611ms)","trace[1285322733] 'applied index is now lower than readState.Index' (duration: 139.034µs)"],"step_count":2} {"level":"info","ts":"2026-02-23T20:12:41.991622Z","caller":"traceutil/trace.go:171","msg":"trace[352424233] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"496.644769ms","start":"2026-02-23T20:12:41.494953Z","end":"2026-02-23T20:12:41.991597Z","steps":["trace[352424233] 'process raft request' (duration: 496.457074ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:12:41.991766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-23T20:12:41.494942Z","time spent":"496.742911ms","remote":"127.0.0.1:58264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-23T20:12:41.99181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.028871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-23T20:12:41.991843Z","caller":"traceutil/trace.go:171","msg":"trace[1195391877] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:896; }","duration":"421.090673ms","start":"2026-02-23T20:12:41.570742Z","end":"2026-02-23T20:12:41.991832Z","steps":["trace[1195391877] 'agreement among raft nodes before linearized reading' (duration: 420.96289ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:12:41.991872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-23T20:12:41.57073Z","time spent":"421.135824ms","remote":"127.0.0.1:58264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-23T20:12:41.991941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.20683ms","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-23T20:12:41.992025Z","caller":"traceutil/trace.go:171","msg":"trace[399484913] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:896; }","duration":"415.316844ms","start":"2026-02-23T20:12:41.576686Z","end":"2026-02-23T20:12:41.992003Z","steps":["trace[399484913] 'agreement among raft nodes before linearized reading' (duration: 415.113548ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:12:41.992066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-23T20:12:41.576674Z","time spent":"415.383725ms","remote":"127.0.0.1:58264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-23T20:12:42.233244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.02777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-02-23T20:12:42.233288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.359192ms","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-23T20:12:42.233332Z","caller":"traceutil/trace.go:171","msg":"trace[470722926] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:898; }","duration":"116.437454ms","start":"2026-02-23T20:12:42.116878Z","end":"2026-02-23T20:12:42.233315Z","steps":["trace[470722926] 'range keys from in-memory index tree' (duration: 116.002284ms)"],"step_count":1} {"level":"info","ts":"2026-02-23T20:12:42.233332Z","caller":"traceutil/trace.go:171","msg":"trace[2054667774] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:898; }","duration":"100.150463ms","start":"2026-02-23T20:12:42.133163Z","end":"2026-02-23T20:12:42.233313Z","steps":["trace[2054667774] 'range keys from in-memory index tree' (duration: 99.917937ms)"],"step_count":1} {"level":"info","ts":"2026-02-23T20:12:42.356149Z","caller":"traceutil/trace.go:171","msg":"trace[1618102683] transaction","detail":"{read_only:false; response_revision:899; number_of_response:1; }","duration":"119.693079ms","start":"2026-02-23T20:12:42.236425Z","end":"2026-02-23T20:12:42.356118Z","steps":["trace[1618102683] 'process raft request' (duration: 119.513074ms)"],"step_count":1} {"level":"info","ts":"2026-02-23T20:12:42.397071Z","caller":"traceutil/trace.go:171","msg":"trace[1867137774] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"159.878149ms","start":"2026-02-23T20:12:42.237163Z","end":"2026-02-23T20:12:42.397041Z","steps":["trace[1867137774] 'process raft request' (duration: 159.726405ms)"],"step_count":1} {"level":"info","ts":"2026-02-23T20:12:54.590931Z","caller":"traceutil/trace.go:171","msg":"trace[1004119629] linearizableReadLoop","detail":"{readStateIndex:974; appliedIndex:973; }","duration":"124.37393ms","start":"2026-02-23T20:12:54.466527Z","end":"2026-02-23T20:12:54.590901Z","steps":["trace[1004119629] 'read index received' (duration: 124.082652ms)","trace[1004119629] 'applied index is now lower than readState.Index' (duration: 290.048µs)"],"step_count":2} {"level":"warn","ts":"2026-02-23T20:12:54.591256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.690388ms","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-23T20:12:54.591304Z","caller":"traceutil/trace.go:171","msg":"trace[735781064] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:934; }","duration":"124.780831ms","start":"2026-02-23T20:12:54.46651Z","end":"2026-02-23T20:12:54.59129Z","steps":["trace[735781064] 'agreement among raft nodes before linearized reading' (duration: 124.512294ms)"],"step_count":1} {"level":"info","ts":"2026-02-23T20:12:54.591716Z","caller":"traceutil/trace.go:171","msg":"trace[659945316] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"132.859369ms","start":"2026-02-23T20:12:54.458837Z","end":"2026-02-23T20:12:54.591697Z","steps":["trace[659945316] 'process raft request' (duration: 131.863014ms)"],"step_count":1} {"level":"info","ts":"2026-02-23T20:12:58.913928Z","caller":"traceutil/trace.go:171","msg":"trace[1151121732] linearizableReadLoop","detail":"{readStateIndex:1006; appliedIndex:1005; }","duration":"240.366523ms","start":"2026-02-23T20:12:58.673537Z","end":"2026-02-23T20:12:58.913904Z","steps":["trace[1151121732] 'read index received' (duration: 240.112807ms)","trace[1151121732] 'applied index is now lower than readState.Index' (duration: 252.626µs)"],"step_count":2} {"level":"info","ts":"2026-02-23T20:12:58.913987Z","caller":"traceutil/trace.go:171","msg":"trace[1401831515] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"249.787948ms","start":"2026-02-23T20:12:58.664165Z","end":"2026-02-23T20:12:58.913953Z","steps":["trace[1401831515] 'process raft request' (duration: 249.579472ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:12:58.914182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.838059ms","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-23T20:12:58.914216Z","caller":"traceutil/trace.go:171","msg":"trace[2120725260] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:965; }","duration":"210.91114ms","start":"2026-02-23T20:12:58.703296Z","end":"2026-02-23T20:12:58.914207Z","steps":["trace[2120725260] 'agreement among raft nodes before linearized reading' (duration: 210.755206ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:12:58.91424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.6433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-23T20:12:58.914364Z","caller":"traceutil/trace.go:171","msg":"trace[2079089069] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:965; }","duration":"240.844446ms","start":"2026-02-23T20:12:58.673492Z","end":"2026-02-23T20:12:58.914337Z","steps":["trace[2079089069] 'agreement among raft nodes before linearized reading' (duration: 240.540328ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:12:59.446789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.527427ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-23T20:12:59.446911Z","caller":"traceutil/trace.go:171","msg":"trace[666939425] linearizableReadLoop","detail":"{readStateIndex:1007; appliedIndex:1006; }","duration":"494.561364ms","start":"2026-02-23T20:12:58.95233Z","end":"2026-02-23T20:12:59.446891Z","steps":["trace[666939425] 'read index received' (duration: 192.790042ms)","trace[666939425] 'applied index is now lower than readState.Index' (duration: 301.770152ms)"],"step_count":2} {"level":"info","ts":"2026-02-23T20:12:59.44716Z","caller":"traceutil/trace.go:171","msg":"trace[539756841] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"529.213341ms","start":"2026-02-23T20:12:58.917934Z","end":"2026-02-23T20:12:59.447147Z","steps":["trace[539756841] 'process raft request' (duration: 227.217402ms)","trace[539756841] 'compare' (duration: 301.368043ms)"],"step_count":2} {"level":"warn","ts":"2026-02-23T20:12:59.44724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-23T20:12:58.917911Z","time spent":"529.294404ms","remote":"127.0.0.1:58264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-23T20:12:59.447445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.120179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-23T20:12:59.44748Z","caller":"traceutil/trace.go:171","msg":"trace[1782557482] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:966; }","duration":"495.199711ms","start":"2026-02-23T20:12:58.95227Z","end":"2026-02-23T20:12:59.447469Z","steps":["trace[1782557482] 'agreement among raft nodes before linearized reading' (duration: 495.14148ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:12:59.447509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-23T20:12:58.952245Z","time spent":"495.258252ms","remote":"127.0.0.1:57964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-23T20:12:59.44834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.24925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-23T20:12:59.448491Z","caller":"traceutil/trace.go:171","msg":"trace[745120519] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:966; }","duration":"274.466236ms","start":"2026-02-23T20:12:59.173995Z","end":"2026-02-23T20:12:59.448461Z","steps":["trace[745120519] 'agreement among raft nodes before linearized reading' (duration: 273.700596ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:13:00.687259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.826725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-23T20:13:00.687348Z","caller":"traceutil/trace.go:171","msg":"trace[32073031] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:967; }","duration":"252.976919ms","start":"2026-02-23T20:13:00.434351Z","end":"2026-02-23T20:13:00.687327Z","steps":["trace[32073031] 'count revisions from in-memory index tree' (duration: 252.747374ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:13:00.687348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.667341ms","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":"warn","ts":"2026-02-23T20:13:00.687263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.570844ms","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-23T20:13:00.687459Z","caller":"traceutil/trace.go:171","msg":"trace[1712147506] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:967; }","duration":"554.830095ms","start":"2026-02-23T20:13:00.132602Z","end":"2026-02-23T20:13:00.687432Z","steps":["trace[1712147506] 'range keys from in-memory index tree' (duration: 554.487536ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:13:00.687505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-23T20:13:00.132579Z","time spent":"554.916368ms","remote":"127.0.0.1:58264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-23T20:13:00.687491Z","caller":"traceutil/trace.go:171","msg":"trace[260116149] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:967; }","duration":"538.871782ms","start":"2026-02-23T20:13:00.148591Z","end":"2026-02-23T20:13:00.687463Z","steps":["trace[260116149] 'range keys from in-memory index tree' (duration: 538.37848ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:13:00.68756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-23T20:13:00.148572Z","time spent":"538.969975ms","remote":"127.0.0.1:58264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-23T20:13:00.891315Z","caller":"traceutil/trace.go:171","msg":"trace[211086383] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"193.348626ms","start":"2026-02-23T20:13:00.697943Z","end":"2026-02-23T20:13:00.891292Z","steps":["trace[211086383] 'process raft request' (duration: 193.178662ms)"],"step_count":1} {"level":"info","ts":"2026-02-23T20:13:00.936136Z","caller":"traceutil/trace.go:171","msg":"trace[127941807] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"234.238304ms","start":"2026-02-23T20:13:00.701875Z","end":"2026-02-23T20:13:00.936113Z","steps":["trace[127941807] 'process raft request' (duration: 233.67454ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:13:01.857763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.159185ms","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-23T20:13:01.857867Z","caller":"traceutil/trace.go:171","msg":"trace[1141878590] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:971; }","duration":"399.301288ms","start":"2026-02-23T20:13:01.458543Z","end":"2026-02-23T20:13:01.857844Z","steps":["trace[1141878590] 'range keys from in-memory index tree' (duration: 398.954279ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:13:01.857935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-23T20:13:01.458522Z","time spent":"399.402401ms","remote":"127.0.0.1:58264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-23T20:13:02.001492Z","caller":"traceutil/trace.go:171","msg":"trace[397607631] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"137.553131ms","start":"2026-02-23T20:13:01.863901Z","end":"2026-02-23T20:13:02.001454Z","steps":["trace[397607631] 'process raft request' (duration: 137.219762ms)"],"step_count":1} {"level":"info","ts":"2026-02-23T20:13:02.308596Z","caller":"traceutil/trace.go:171","msg":"trace[197270496] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"179.480827ms","start":"2026-02-23T20:13:02.129085Z","end":"2026-02-23T20:13:02.308566Z","steps":["trace[197270496] 'process raft request' (duration: 179.284492ms)"],"step_count":1} {"level":"info","ts":"2026-02-23T20:13:10.437776Z","caller":"traceutil/trace.go:171","msg":"trace[398845849] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"153.537036ms","start":"2026-02-23T20:13:10.284191Z","end":"2026-02-23T20:13:10.437728Z","steps":["trace[398845849] 'process raft request' (duration: 153.247218ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:13:10.918809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.638732ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-23T20:13:10.919048Z","caller":"traceutil/trace.go:171","msg":"trace[733688872] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"475.05881ms","start":"2026-02-23T20:13:10.443964Z","end":"2026-02-23T20:13:10.919023Z","steps":["trace[733688872] 'process raft request' (duration: 47.075549ms)","trace[733688872] 'compare' (duration: 427.463887ms)"],"step_count":2} {"level":"warn","ts":"2026-02-23T20:13:10.919116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-23T20:13:10.443908Z","time spent":"475.176942ms","remote":"127.0.0.1:58264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-23T20:16:22.281569Z","caller":"traceutil/trace.go:171","msg":"trace[807998879] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"227.271358ms","start":"2026-02-23T20:16:22.054281Z","end":"2026-02-23T20:16:22.281552Z","steps":["trace[807998879] 'process raft request' (duration: 227.072463ms)"],"step_count":1} {"level":"info","ts":"2026-02-23T20:16:22.281541Z","caller":"traceutil/trace.go:171","msg":"trace[257852840] linearizableReadLoop","detail":"{readStateIndex:1929; appliedIndex:1928; }","duration":"225.727087ms","start":"2026-02-23T20:16:22.055784Z","end":"2026-02-23T20:16:22.281511Z","steps":["trace[257852840] 'read index received' (duration: 225.560033ms)","trace[257852840] 'applied index is now lower than readState.Index' (duration: 166.094µs)"],"step_count":2} {"level":"warn","ts":"2026-02-23T20:16:22.281747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.939864ms","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-23T20:16:22.281799Z","caller":"traceutil/trace.go:171","msg":"trace[1257955626] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1847; }","duration":"226.020485ms","start":"2026-02-23T20:16:22.055765Z","end":"2026-02-23T20:16:22.281786Z","steps":["trace[1257955626] 'agreement among raft nodes before linearized reading' (duration: 225.848441ms)"],"step_count":1} {"level":"info","ts":"2026-02-23T20:16:22.307181Z","caller":"traceutil/trace.go:171","msg":"trace[713835354] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"251.279778ms","start":"2026-02-23T20:16:22.055833Z","end":"2026-02-23T20:16:22.307113Z","steps":["trace[713835354] 'process raft request' (duration: 250.984431ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:16:22.307294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.024896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-02-23T20:16:22.307389Z","caller":"traceutil/trace.go:171","msg":"trace[739656288] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1848; }","duration":"103.156539ms","start":"2026-02-23T20:16:22.204188Z","end":"2026-02-23T20:16:22.307345Z","steps":["trace[739656288] 'agreement among raft nodes before linearized reading' (duration: 102.950913ms)"],"step_count":1} {"level":"warn","ts":"2026-02-23T20:16:22.307333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.485008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-23T20:16:22.30761Z","caller":"traceutil/trace.go:171","msg":"trace[642703664] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1848; }","duration":"250.786256ms","start":"2026-02-23T20:16:22.056792Z","end":"2026-02-23T20:16:22.307578Z","steps":["trace[642703664] 'agreement among raft nodes before linearized reading' (duration: 250.343534ms)"],"step_count":1}