{"level":"warn","ts":"2026-02-26T17:56:55.070285Z","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-26T17:56:55.070394Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.138: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.138:2380","--initial-cluster=instance=https://199.204.45.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.138: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-26T17:56:55.070487Z","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-26T17:56:55.070502Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-02-26T17:56:55.070527Z","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-26T17:56:55.071188Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"]} {"level":"info","ts":"2026-02-26T17:56:55.071259Z","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://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.138: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-26T17:56:55.077795Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.3109ms"} {"level":"info","ts":"2026-02-26T17:56:55.086887Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3d52791b64f7591","cluster-id":"90076b89649fe294"} {"level":"info","ts":"2026-02-26T17:56:55.086973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=()"} {"level":"info","ts":"2026-02-26T17:56:55.086993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 0"} {"level":"info","ts":"2026-02-26T17:56:55.087003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3d52791b64f7591 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-26T17:56:55.087024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 1"} {"level":"info","ts":"2026-02-26T17:56:55.087056Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"warn","ts":"2026-02-26T17:56:55.101727Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-26T17:56:55.107032Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-26T17:56:55.108246Z","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-26T17:56:55.112734Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3d52791b64f7591","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-26T17:56:55.112814Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3d52791b64f7591","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-26T17:56:55.113516Z","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-26T17:56:55.113763Z","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-26T17:56:55.113776Z","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-26T17:56:55.114729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"info","ts":"2026-02-26T17:56:55.115044Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","added-peer-id":"f3d52791b64f7591","added-peer-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-02-26T17:56:55.123045Z","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-26T17:56:55.123207Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-02-26T17:56:55.123276Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-02-26T17:56:55.123297Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3d52791b64f7591","initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-26T17:56:55.123332Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-26T17:56:55.387771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 is starting a new election at term 1"} {"level":"info","ts":"2026-02-26T17:56:55.387878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-26T17:56:55.387944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgPreVoteResp from f3d52791b64f7591 at term 1"} {"level":"info","ts":"2026-02-26T17:56:55.387977Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became candidate at term 2"} {"level":"info","ts":"2026-02-26T17:56:55.387996Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgVoteResp from f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-02-26T17:56:55.388092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became leader at term 2"} {"level":"info","ts":"2026-02-26T17:56:55.388221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3d52791b64f7591 elected leader f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-02-26T17:56:55.389487Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3d52791b64f7591","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.138:2379]}","request-path":"/0/members/f3d52791b64f7591/attributes","cluster-id":"90076b89649fe294","publish-timeout":"7s"} {"level":"info","ts":"2026-02-26T17:56:55.389884Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T17:56:55.389924Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T17:56:55.390406Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T17:56:55.390868Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-26T17:56:55.391057Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-26T17:56:55.392334Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-26T17:56:55.393526Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T17:56:55.393805Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T17:56:55.39397Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T17:56:55.396637Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.138:2379"} {"level":"warn","ts":"2026-02-26T17:57:15.472858Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471724564009366169,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-26T17:57:15.599145Z","caller":"traceutil/trace.go:171","msg":"trace[218588259] linearizableReadLoop","detail":"{readStateIndex:428; appliedIndex:427; }","duration":"627.299042ms","start":"2026-02-26T17:57:14.971815Z","end":"2026-02-26T17:57:15.599114Z","steps":["trace[218588259] 'read index received' (duration: 627.014394ms)","trace[218588259] 'applied index is now lower than readState.Index' (duration: 283.057µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:57:15.59921Z","caller":"traceutil/trace.go:171","msg":"trace[1258999138] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"658.421013ms","start":"2026-02-26T17:57:14.940758Z","end":"2026-02-26T17:57:15.599179Z","steps":["trace[1258999138] 'process raft request' (duration: 658.175627ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:15.599323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.485116ms","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-26T17:57:15.599398Z","caller":"traceutil/trace.go:171","msg":"trace[755778998] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:414; }","duration":"627.597667ms","start":"2026-02-26T17:57:14.971785Z","end":"2026-02-26T17:57:15.599383Z","steps":["trace[755778998] 'agreement among raft nodes before linearized reading' (duration: 627.479175ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:15.599436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:14.971772Z","time spent":"627.654459ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-26T17:57:15.600026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:14.940745Z","time spent":"658.536635ms","remote":"127.0.0.1:53710","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-26T17:57:15.600298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.141171ms","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-26T17:57:15.600844Z","caller":"traceutil/trace.go:171","msg":"trace[895362636] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:414; }","duration":"624.373726ms","start":"2026-02-26T17:57:14.976042Z","end":"2026-02-26T17:57:15.600415Z","steps":["trace[895362636] 'agreement among raft nodes before linearized reading' (duration: 623.555398ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:15.600974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:14.976022Z","time spent":"624.933019ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-26T17:57:16.08181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.126121ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T17:57:16.081886Z","caller":"traceutil/trace.go:171","msg":"trace[2040120571] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"478.995937ms","start":"2026-02-26T17:57:15.602878Z","end":"2026-02-26T17:57:16.081873Z","steps":["trace[2040120571] 'process raft request' (duration: 180.638621ms)","trace[2040120571] 'compare' (duration: 297.980158ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:57:16.081924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:15.602857Z","time spent":"479.050109ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T17:57:16.295472Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471724564009366172,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T17:57:16.746101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.168131ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T17:57:16.746243Z","caller":"traceutil/trace.go:171","msg":"trace[1705705586] linearizableReadLoop","detail":"{readStateIndex:431; appliedIndex:429; }","duration":"951.564073ms","start":"2026-02-26T17:57:15.794664Z","end":"2026-02-26T17:57:16.746228Z","steps":["trace[1705705586] 'read index received' (duration: 563.150897ms)","trace[1705705586] 'applied index is now lower than readState.Index' (duration: 388.412366ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:57:16.746329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"951.669235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:57:16.746354Z","caller":"traceutil/trace.go:171","msg":"trace[2083956174] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:417; }","duration":"951.725467ms","start":"2026-02-26T17:57:15.79462Z","end":"2026-02-26T17:57:16.746345Z","steps":["trace[2083956174] 'agreement among raft nodes before linearized reading' (duration: 951.658255ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:16.746381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:15.794605Z","time spent":"951.769208ms","remote":"127.0.0.1:53448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-26T17:57:16.746393Z","caller":"traceutil/trace.go:171","msg":"trace[1568620428] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"1.142277749s","start":"2026-02-26T17:57:15.604097Z","end":"2026-02-26T17:57:16.746374Z","steps":["trace[1568620428] 'process raft request' (duration: 753.77195ms)","trace[1568620428] 'compare' (duration: 387.823604ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:57:16.746474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:15.60408Z","time spent":"1.14235124s","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T17:57:16.74654Z","caller":"traceutil/trace.go:171","msg":"trace[1520100413] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"1.14233232s","start":"2026-02-26T17:57:15.604196Z","end":"2026-02-26T17:57:16.746529Z","steps":["trace[1520100413] 'process raft request' (duration: 1.141981202s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:16.746591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:15.604175Z","time spent":"1.142387811s","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T17:57:25.428678Z","caller":"traceutil/trace.go:171","msg":"trace[2077304491] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"222.652784ms","start":"2026-02-26T17:57:25.206007Z","end":"2026-02-26T17:57:25.42866Z","steps":["trace[2077304491] 'process raft request' (duration: 222.553872ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:57:31.643946Z","caller":"traceutil/trace.go:171","msg":"trace[462243563] linearizableReadLoop","detail":"{readStateIndex:507; appliedIndex:506; }","duration":"158.439899ms","start":"2026-02-26T17:57:31.485482Z","end":"2026-02-26T17:57:31.643921Z","steps":["trace[462243563] 'read index received' (duration: 158.307216ms)","trace[462243563] 'applied index is now lower than readState.Index' (duration: 131.763µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:57:31.644024Z","caller":"traceutil/trace.go:171","msg":"trace[1302026766] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"431.572563ms","start":"2026-02-26T17:57:31.21242Z","end":"2026-02-26T17:57:31.643993Z","steps":["trace[1302026766] 'process raft request' (duration: 431.362279ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:31.644179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:31.212394Z","time spent":"431.708947ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T17:57:31.644238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.736535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-t2wjw\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-02-26T17:57:31.64434Z","caller":"traceutil/trace.go:171","msg":"trace[901048899] range","detail":"{range_begin:/registry/pods/kube-system/cilium-t2wjw; range_end:; response_count:1; response_revision:490; }","duration":"158.890459ms","start":"2026-02-26T17:57:31.485431Z","end":"2026-02-26T17:57:31.644321Z","steps":["trace[901048899] 'agreement among raft nodes before linearized reading' (duration: 158.610682ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:32.178222Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471724564009366342,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-26T17:57:32.243438Z","caller":"traceutil/trace.go:171","msg":"trace[252274205] linearizableReadLoop","detail":"{readStateIndex:508; appliedIndex:507; }","duration":"565.891947ms","start":"2026-02-26T17:57:31.677523Z","end":"2026-02-26T17:57:32.243415Z","steps":["trace[252274205] 'read index received' (duration: 565.662962ms)","trace[252274205] 'applied index is now lower than readState.Index' (duration: 228.285µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:57:32.24354Z","caller":"traceutil/trace.go:171","msg":"trace[1404206252] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"583.630091ms","start":"2026-02-26T17:57:31.659902Z","end":"2026-02-26T17:57:32.243532Z","steps":["trace[1404206252] 'process raft request' (duration: 583.370455ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:32.24364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:31.659874Z","time spent":"583.692672ms","remote":"127.0.0.1:53640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T17:57:32.24382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.305076ms","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-26T17:57:32.243851Z","caller":"traceutil/trace.go:171","msg":"trace[1464343113] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:491; }","duration":"566.364528ms","start":"2026-02-26T17:57:31.677476Z","end":"2026-02-26T17:57:32.24384Z","steps":["trace[1464343113] 'agreement among raft nodes before linearized reading' (duration: 566.282566ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:32.243882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:31.677458Z","time spent":"566.417798ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-26T17:57:32.592457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.385347ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T17:57:32.592633Z","caller":"traceutil/trace.go:171","msg":"trace[1902551378] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"344.392668ms","start":"2026-02-26T17:57:32.248223Z","end":"2026-02-26T17:57:32.592616Z","steps":["trace[1902551378] 'process raft request' (duration: 344.341077ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:32.592706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:32.248201Z","time spent":"344.47333ms","remote":"127.0.0.1:53710","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-26T17:57:32.592679Z","caller":"traceutil/trace.go:171","msg":"trace[531034086] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"345.318499ms","start":"2026-02-26T17:57:32.247322Z","end":"2026-02-26T17:57:32.592641Z","steps":["trace[531034086] 'process raft request' (duration: 173.670757ms)","trace[531034086] 'compare' (duration: 171.233792ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:57:32.592847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:32.247305Z","time spent":"345.456662ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T17:57:33.928586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.093183939s","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-26T17:57:33.928714Z","caller":"traceutil/trace.go:171","msg":"trace[45363106] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:493; }","duration":"1.093362523s","start":"2026-02-26T17:57:32.835331Z","end":"2026-02-26T17:57:33.928693Z","steps":["trace[45363106] 'range keys from in-memory index tree' (duration: 1.092992203s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:33.928642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.566409ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T17:57:33.928758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:32.835309Z","time spent":"1.093439414s","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-26T17:57:33.928785Z","caller":"traceutil/trace.go:171","msg":"trace[1065370124] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:493; }","duration":"528.743383ms","start":"2026-02-26T17:57:33.400017Z","end":"2026-02-26T17:57:33.92876Z","steps":["trace[1065370124] 'range keys from in-memory index tree' (duration: 528.548049ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:33.928827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.13242579s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T17:57:33.928603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.099037529s","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-26T17:57:33.928941Z","caller":"traceutil/trace.go:171","msg":"trace[1074315747] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:493; }","duration":"1.132574983s","start":"2026-02-26T17:57:32.796325Z","end":"2026-02-26T17:57:33.9289Z","steps":["trace[1074315747] 'range keys from in-memory index tree' (duration: 1.132355858s)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:57:33.928983Z","caller":"traceutil/trace.go:171","msg":"trace[1537463436] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:493; }","duration":"1.099479438s","start":"2026-02-26T17:57:32.82949Z","end":"2026-02-26T17:57:33.928969Z","steps":["trace[1537463436] 'range keys from in-memory index tree' (duration: 1.098815822s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:33.928991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:32.796306Z","time spent":"1.132675325s","remote":"127.0.0.1:53448","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-26T17:57:33.929021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:32.829472Z","time spent":"1.0995397s","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-26T17:57:33.928859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:33.053088Z","time spent":"875.762399ms","remote":"127.0.0.1:36602","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-26T17:57:34.132932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.526565ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-26T17:57:34.1333Z","caller":"traceutil/trace.go:171","msg":"trace[918787076] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"198.10983ms","start":"2026-02-26T17:57:33.93517Z","end":"2026-02-26T17:57:34.13328Z","steps":["trace[918787076] 'process raft request' (duration: 197.954007ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:57:34.133297Z","caller":"traceutil/trace.go:171","msg":"trace[1352044749] linearizableReadLoop","detail":"{readStateIndex:511; appliedIndex:510; }","duration":"202.501138ms","start":"2026-02-26T17:57:33.930768Z","end":"2026-02-26T17:57:34.133269Z","steps":["trace[1352044749] 'read index received' (duration: 569.093µs)","trace[1352044749] 'applied index is now lower than readState.Index' (duration: 201.926065ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:57:34.133532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.746103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:57:34.133584Z","caller":"traceutil/trace.go:171","msg":"trace[978920716] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:494; }","duration":"202.809755ms","start":"2026-02-26T17:57:33.930762Z","end":"2026-02-26T17:57:34.133572Z","steps":["trace[978920716] 'agreement among raft nodes before linearized reading' (duration: 202.5847ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:34.378731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.690535ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T17:57:34.378831Z","caller":"traceutil/trace.go:171","msg":"trace[1482549445] linearizableReadLoop","detail":"{readStateIndex:513; appliedIndex:512; }","duration":"238.141228ms","start":"2026-02-26T17:57:34.140674Z","end":"2026-02-26T17:57:34.378815Z","steps":["trace[1482549445] 'read index received' (duration: 115.265139ms)","trace[1482549445] 'applied index is now lower than readState.Index' (duration: 122.875079ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:57:34.37889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.21253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:57:34.378913Z","caller":"traceutil/trace.go:171","msg":"trace[1166759439] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:495; }","duration":"238.255841ms","start":"2026-02-26T17:57:34.140649Z","end":"2026-02-26T17:57:34.378905Z","steps":["trace[1166759439] 'agreement among raft nodes before linearized reading' (duration: 238.2117ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:57:34.379077Z","caller":"traceutil/trace.go:171","msg":"trace[1741293108] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"443.319415ms","start":"2026-02-26T17:57:33.935721Z","end":"2026-02-26T17:57:34.37904Z","steps":["trace[1741293108] 'process raft request' (duration: 320.226712ms)","trace[1741293108] 'compare' (duration: 122.564102ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:57:34.37943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:33.935706Z","time spent":"443.607551ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T17:57:53.299253Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471724564009366702,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-26T17:57:53.741126Z","caller":"traceutil/trace.go:171","msg":"trace[1095545534] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"944.481295ms","start":"2026-02-26T17:57:52.796618Z","end":"2026-02-26T17:57:53.7411Z","steps":["trace[1095545534] 'process raft request' (duration: 944.334532ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:53.741452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:52.796594Z","time spent":"944.598487ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T17:57:53.953641Z","caller":"traceutil/trace.go:171","msg":"trace[1207667553] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"1.156254631s","start":"2026-02-26T17:57:52.797366Z","end":"2026-02-26T17:57:53.95362Z","steps":["trace[1207667553] 'process raft request' (duration: 1.086842172s)","trace[1207667553] 'compare' (duration: 69.303537ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:57:53.95377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:52.797318Z","time spent":"1.156393204s","remote":"127.0.0.1:53710","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-26T17:57:54.108553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.928085ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-26T17:57:54.108647Z","caller":"traceutil/trace.go:171","msg":"trace[958152655] linearizableReadLoop","detail":"{readStateIndex:702; appliedIndex:700; }","duration":"1.310454181s","start":"2026-02-26T17:57:52.798176Z","end":"2026-02-26T17:57:54.10863Z","steps":["trace[958152655] 'read index received' (duration: 942.768098ms)","trace[958152655] 'applied index is now lower than readState.Index' (duration: 367.684383ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:57:54.10873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.310552643s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:57:54.108763Z","caller":"traceutil/trace.go:171","msg":"trace[1658881539] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:680; }","duration":"1.310637195s","start":"2026-02-26T17:57:52.798116Z","end":"2026-02-26T17:57:54.108753Z","steps":["trace[1658881539] 'agreement among raft nodes before linearized reading' (duration: 1.310559383s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:54.108796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:52.797971Z","time spent":"1.310817349s","remote":"127.0.0.1:53448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-26T17:57:54.542297Z","caller":"traceutil/trace.go:171","msg":"trace[1877522434] linearizableReadLoop","detail":"{readStateIndex:704; appliedIndex:703; }","duration":"291.398222ms","start":"2026-02-26T17:57:54.250881Z","end":"2026-02-26T17:57:54.542279Z","steps":["trace[1877522434] 'read index received' (duration: 291.337351ms)","trace[1877522434] 'applied index is now lower than readState.Index' (duration: 60.171µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:57:54.542392Z","caller":"traceutil/trace.go:171","msg":"trace[719474556] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"310.69969ms","start":"2026-02-26T17:57:54.231685Z","end":"2026-02-26T17:57:54.542385Z","steps":["trace[719474556] 'process raft request' (duration: 310.452715ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:54.542462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:54.231672Z","time spent":"310.736381ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T17:57:54.542654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.77139ms","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-26T17:57:54.54268Z","caller":"traceutil/trace.go:171","msg":"trace[1010933460] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:681; }","duration":"291.809091ms","start":"2026-02-26T17:57:54.250865Z","end":"2026-02-26T17:57:54.542674Z","steps":["trace[1010933460] 'agreement among raft nodes before linearized reading' (duration: 291.682448ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:57:54.71343Z","caller":"traceutil/trace.go:171","msg":"trace[1746591277] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"166.964823ms","start":"2026-02-26T17:57:54.546434Z","end":"2026-02-26T17:57:54.713399Z","steps":["trace[1746591277] 'process raft request' (duration: 160.04878ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:57:54.722138Z","caller":"traceutil/trace.go:171","msg":"trace[1912915221] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"173.668031ms","start":"2026-02-26T17:57:54.548362Z","end":"2026-02-26T17:57:54.72203Z","steps":["trace[1912915221] 'process raft request' (duration: 173.435456ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:57:56.015595Z","caller":"traceutil/trace.go:171","msg":"trace[210401124] linearizableReadLoop","detail":"{readStateIndex:707; appliedIndex:706; }","duration":"218.562226ms","start":"2026-02-26T17:57:55.797009Z","end":"2026-02-26T17:57:56.015571Z","steps":["trace[210401124] 'read index received' (duration: 218.381813ms)","trace[210401124] 'applied index is now lower than readState.Index' (duration: 179.033µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:57:56.015715Z","caller":"traceutil/trace.go:171","msg":"trace[584247628] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"265.022637ms","start":"2026-02-26T17:57:55.750683Z","end":"2026-02-26T17:57:56.015706Z","steps":["trace[584247628] 'process raft request' (duration: 264.732141ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:56.016065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.040778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:57:56.01611Z","caller":"traceutil/trace.go:171","msg":"trace[490872802] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:684; }","duration":"219.15325ms","start":"2026-02-26T17:57:55.796942Z","end":"2026-02-26T17:57:56.016096Z","steps":["trace[490872802] 'agreement among raft nodes before linearized reading' (duration: 219.078118ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:18.513935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.944681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-26T17:58:18.514042Z","caller":"traceutil/trace.go:171","msg":"trace[1720777480] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:1; response_revision:752; }","duration":"139.158006ms","start":"2026-02-26T17:58:18.374863Z","end":"2026-02-26T17:58:18.514021Z","steps":["trace[1720777480] 'range keys from in-memory index tree' (duration: 138.657184ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:20.337181Z","caller":"traceutil/trace.go:171","msg":"trace[5865936] linearizableReadLoop","detail":"{readStateIndex:787; appliedIndex:786; }","duration":"163.219749ms","start":"2026-02-26T17:58:20.173939Z","end":"2026-02-26T17:58:20.337158Z","steps":["trace[5865936] 'read index received' (duration: 162.987354ms)","trace[5865936] 'applied index is now lower than readState.Index' (duration: 231.075µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:58:20.337259Z","caller":"traceutil/trace.go:171","msg":"trace[908967795] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"182.801614ms","start":"2026-02-26T17:58:20.154424Z","end":"2026-02-26T17:58:20.337226Z","steps":["trace[908967795] 'process raft request' (duration: 182.581349ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:20.3374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.427524ms","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-26T17:58:20.337436Z","caller":"traceutil/trace.go:171","msg":"trace[1543022818] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:758; }","duration":"163.523796ms","start":"2026-02-26T17:58:20.173902Z","end":"2026-02-26T17:58:20.337426Z","steps":["trace[1543022818] 'agreement among raft nodes before linearized reading' (duration: 163.350992ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:22.539382Z","caller":"traceutil/trace.go:171","msg":"trace[1156455662] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"133.398099ms","start":"2026-02-26T17:58:22.405963Z","end":"2026-02-26T17:58:22.539361Z","steps":["trace[1156455662] 'process raft request' (duration: 133.195534ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:26.889812Z","caller":"traceutil/trace.go:171","msg":"trace[335791299] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"117.073036ms","start":"2026-02-26T17:58:26.772674Z","end":"2026-02-26T17:58:26.889747Z","steps":["trace[335791299] 'process raft request' (duration: 113.17779ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:34.570233Z","caller":"traceutil/trace.go:171","msg":"trace[1297099029] transaction","detail":"{read_only:false; response_revision:848; number_of_response:1; }","duration":"136.035527ms","start":"2026-02-26T17:58:34.434173Z","end":"2026-02-26T17:58:34.570209Z","steps":["trace[1297099029] 'process raft request' (duration: 135.834623ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:37.054718Z","caller":"traceutil/trace.go:171","msg":"trace[1744797666] linearizableReadLoop","detail":"{readStateIndex:887; appliedIndex:886; }","duration":"416.655829ms","start":"2026-02-26T17:58:36.638027Z","end":"2026-02-26T17:58:37.054682Z","steps":["trace[1744797666] 'read index received' (duration: 416.341001ms)","trace[1744797666] 'applied index is now lower than readState.Index' (duration: 313.008µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:58:37.054784Z","caller":"traceutil/trace.go:171","msg":"trace[1086504851] transaction","detail":"{read_only:false; response_revision:853; number_of_response:1; }","duration":"476.16875ms","start":"2026-02-26T17:58:36.578576Z","end":"2026-02-26T17:58:37.054745Z","steps":["trace[1086504851] 'process raft request' (duration: 475.903343ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:37.054961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:36.578556Z","time spent":"476.309042ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T17:58:37.055101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.026308ms","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-26T17:58:37.055166Z","caller":"traceutil/trace.go:171","msg":"trace[1777452671] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:853; }","duration":"417.176202ms","start":"2026-02-26T17:58:36.637978Z","end":"2026-02-26T17:58:37.055155Z","steps":["trace[1777452671] 'agreement among raft nodes before linearized reading' (duration: 416.895446ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:37.055203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:36.637956Z","time spent":"417.238723ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-26T17:58:37.055332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.293782ms","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-26T17:58:37.055438Z","caller":"traceutil/trace.go:171","msg":"trace[1681600230] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:853; }","duration":"108.434815ms","start":"2026-02-26T17:58:36.946983Z","end":"2026-02-26T17:58:37.055417Z","steps":["trace[1681600230] 'agreement among raft nodes before linearized reading' (duration: 108.16388ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:37.202725Z","caller":"traceutil/trace.go:171","msg":"trace[1155102090] transaction","detail":"{read_only:false; response_revision:854; number_of_response:1; }","duration":"143.534843ms","start":"2026-02-26T17:58:37.059151Z","end":"2026-02-26T17:58:37.202686Z","steps":["trace[1155102090] 'process raft request' (duration: 143.370569ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:37.203255Z","caller":"traceutil/trace.go:171","msg":"trace[1192307715] transaction","detail":"{read_only:false; response_revision:857; number_of_response:1; }","duration":"143.252777ms","start":"2026-02-26T17:58:37.059994Z","end":"2026-02-26T17:58:37.203247Z","steps":["trace[1192307715] 'process raft request' (duration: 143.231677ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:37.203335Z","caller":"traceutil/trace.go:171","msg":"trace[130475130] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"143.650346ms","start":"2026-02-26T17:58:37.059651Z","end":"2026-02-26T17:58:37.203301Z","steps":["trace[130475130] 'process raft request' (duration: 143.557394ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:37.203339Z","caller":"traceutil/trace.go:171","msg":"trace[808800526] transaction","detail":"{read_only:false; response_revision:855; number_of_response:1; }","duration":"143.681987ms","start":"2026-02-26T17:58:37.059602Z","end":"2026-02-26T17:58:37.203284Z","steps":["trace[808800526] 'process raft request' (duration: 143.563154ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:55.882742Z","caller":"traceutil/trace.go:171","msg":"trace[362566594] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"516.607757ms","start":"2026-02-26T17:58:55.366102Z","end":"2026-02-26T17:58:55.88271Z","steps":["trace[362566594] 'process raft request' (duration: 516.385121ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:55.882651Z","caller":"traceutil/trace.go:171","msg":"trace[271034162] linearizableReadLoop","detail":"{readStateIndex:963; appliedIndex:962; }","duration":"410.656771ms","start":"2026-02-26T17:58:55.471969Z","end":"2026-02-26T17:58:55.882626Z","steps":["trace[271034162] 'read index received' (duration: 410.434505ms)","trace[271034162] 'applied index is now lower than readState.Index' (duration: 221.376µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:58:55.883745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:55.366087Z","time spent":"517.570967ms","remote":"127.0.0.1:53710","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-26T17:58:55.886094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.203766ms","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":"warn","ts":"2026-02-26T17:58:55.88615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.171218ms","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-26T17:58:55.886174Z","caller":"traceutil/trace.go:171","msg":"trace[656109560] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:925; }","duration":"381.347799ms","start":"2026-02-26T17:58:55.504809Z","end":"2026-02-26T17:58:55.886157Z","steps":["trace[656109560] 'agreement among raft nodes before linearized reading' (duration: 378.930985ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:55.88621Z","caller":"traceutil/trace.go:171","msg":"trace[253931611] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:925; }","duration":"414.269131ms","start":"2026-02-26T17:58:55.471926Z","end":"2026-02-26T17:58:55.886195Z","steps":["trace[253931611] 'agreement among raft nodes before linearized reading' (duration: 410.900866ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:55.886223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:55.504787Z","time spent":"381.42726ms","remote":"127.0.0.1:53710","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-26T17:58:55.886249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:55.471905Z","time spent":"414.336482ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-26T17:58:55.886244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.304663ms","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-26T17:58:55.886306Z","caller":"traceutil/trace.go:171","msg":"trace[1389562922] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:925; }","duration":"379.390006ms","start":"2026-02-26T17:58:55.506898Z","end":"2026-02-26T17:58:55.886288Z","steps":["trace[1389562922] 'agreement among raft nodes before linearized reading' (duration: 379.239622ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:55.886346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:55.506888Z","time spent":"379.449697ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-26T17:58:56.77759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.519025ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T17:58:56.777867Z","caller":"traceutil/trace.go:171","msg":"trace[727678038] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"857.847243ms","start":"2026-02-26T17:58:55.920003Z","end":"2026-02-26T17:58:56.77785Z","steps":["trace[727678038] 'process raft request' (duration: 857.808182ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:56.777946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:55.919996Z","time spent":"857.915984ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T17:58:56.778341Z","caller":"traceutil/trace.go:171","msg":"trace[875398337] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"875.439463ms","start":"2026-02-26T17:58:55.902883Z","end":"2026-02-26T17:58:56.778323Z","steps":["trace[875398337] 'process raft request' (duration: 241.074609ms)","trace[875398337] 'compare' (duration: 633.040685ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:58:56.778452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:55.902866Z","time spent":"875.548206ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T17:58:56.778591Z","caller":"traceutil/trace.go:171","msg":"trace[2119155297] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"858.65324ms","start":"2026-02-26T17:58:55.919929Z","end":"2026-02-26T17:58:56.778582Z","steps":["trace[2119155297] 'process raft request' (duration: 857.827212ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:56.778649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:55.919911Z","time spent":"858.710702ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T17:58:57.418626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.755701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:58:57.418686Z","caller":"traceutil/trace.go:171","msg":"trace[1995173408] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:930; }","duration":"136.871323ms","start":"2026-02-26T17:58:57.281803Z","end":"2026-02-26T17:58:57.418675Z","steps":["trace[1995173408] 'count revisions from in-memory index tree' (duration: 136.627358ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:58.6689Z","caller":"traceutil/trace.go:171","msg":"trace[707616736] linearizableReadLoop","detail":"{readStateIndex:970; appliedIndex:969; }","duration":"375.066539ms","start":"2026-02-26T17:58:58.293807Z","end":"2026-02-26T17:58:58.668874Z","steps":["trace[707616736] 'read index received' (duration: 367.257885ms)","trace[707616736] 'applied index is now lower than readState.Index' (duration: 7.807034ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:58:58.668916Z","caller":"traceutil/trace.go:171","msg":"trace[265448072] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"451.906417ms","start":"2026-02-26T17:58:58.216987Z","end":"2026-02-26T17:58:58.668893Z","steps":["trace[265448072] 'process raft request' (duration: 443.999171ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:58.669035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:58.216947Z","time spent":"452.02925ms","remote":"127.0.0.1:53538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":787,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T17:58:58.66907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.245572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:58:58.669099Z","caller":"traceutil/trace.go:171","msg":"trace[491482869] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:932; }","duration":"375.316684ms","start":"2026-02-26T17:58:58.293772Z","end":"2026-02-26T17:58:58.669089Z","steps":["trace[491482869] 'agreement among raft nodes before linearized reading' (duration: 375.219522ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:58.66913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:58.293752Z","time spent":"375.371326ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-26T17:58:58.669377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.317797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-26T17:58:58.669404Z","caller":"traceutil/trace.go:171","msg":"trace[152280704] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:1; response_revision:932; }","duration":"291.370018ms","start":"2026-02-26T17:58:58.378028Z","end":"2026-02-26T17:58:58.669398Z","steps":["trace[152280704] 'agreement among raft nodes before linearized reading' (duration: 291.269136ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:58.669496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.000865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T17:58:58.669544Z","caller":"traceutil/trace.go:171","msg":"trace[1403563489] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:932; }","duration":"289.101717ms","start":"2026-02-26T17:58:58.380431Z","end":"2026-02-26T17:58:58.669533Z","steps":["trace[1403563489] 'agreement among raft nodes before linearized reading' (duration: 289.022825ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:59.665758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.156419ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"warn","ts":"2026-02-26T17:58:59.666259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:58.670746Z","time spent":"995.508852ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-26T17:58:59.699207Z","caller":"traceutil/trace.go:171","msg":"trace[1331337792] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"1.025392917s","start":"2026-02-26T17:58:58.673795Z","end":"2026-02-26T17:58:59.699188Z","steps":["trace[1331337792] 'process raft request' (duration: 1.025232353s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:59.699305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:58.673775Z","time spent":"1.025486149s","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T17:58:59.699605Z","caller":"traceutil/trace.go:171","msg":"trace[1655861848] linearizableReadLoop","detail":"{readStateIndex:972; appliedIndex:970; }","duration":"906.195447ms","start":"2026-02-26T17:58:58.793399Z","end":"2026-02-26T17:58:59.699595Z","steps":["trace[1655861848] 'read index received' (duration: 431.184776ms)","trace[1655861848] 'applied index is now lower than readState.Index' (duration: 474.553541ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:58:59.699858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"906.432862ms","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-26T17:58:59.699936Z","caller":"traceutil/trace.go:171","msg":"trace[175473828] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:933; }","duration":"906.553105ms","start":"2026-02-26T17:58:58.793366Z","end":"2026-02-26T17:58:59.699919Z","steps":["trace[175473828] 'agreement among raft nodes before linearized reading' (duration: 906.281799ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:59.699979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:58.79335Z","time spent":"906.621496ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-26T17:58:59.754991Z","caller":"traceutil/trace.go:171","msg":"trace[861828314] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"527.466147ms","start":"2026-02-26T17:58:59.227504Z","end":"2026-02-26T17:58:59.75497Z","steps":["trace[861828314] 'process raft request' (duration: 527.234452ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:59.755194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"961.667931ms","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-26T17:58:59.755268Z","caller":"traceutil/trace.go:171","msg":"trace[229730337] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:935; }","duration":"961.767682ms","start":"2026-02-26T17:58:58.793484Z","end":"2026-02-26T17:58:59.755251Z","steps":["trace[229730337] 'agreement among raft nodes before linearized reading' (duration: 961.627099ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:59.755269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.509022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-02-26T17:58:59.755317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:58.793467Z","time spent":"961.840484ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-26T17:58:59.755349Z","caller":"traceutil/trace.go:171","msg":"trace[1759313899] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:935; }","duration":"565.624045ms","start":"2026-02-26T17:58:59.189711Z","end":"2026-02-26T17:58:59.755335Z","steps":["trace[1759313899] 'agreement among raft nodes before linearized reading' (duration: 565.38008ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:59.755467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:59.189692Z","time spent":"565.764789ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-26T17:58:59.755492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:59.227479Z","time spent":"527.583519ms","remote":"127.0.0.1:53538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":787,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T17:58:59.755704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.294965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T17:58:59.755747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"962.122171ms","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-26T17:58:59.755771Z","caller":"traceutil/trace.go:171","msg":"trace[547273345] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:935; }","duration":"959.006641ms","start":"2026-02-26T17:58:58.796753Z","end":"2026-02-26T17:58:59.755759Z","steps":["trace[547273345] 'agreement among raft nodes before linearized reading' (duration: 958.222674ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:59.755787Z","caller":"traceutil/trace.go:171","msg":"trace[614957669] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:935; }","duration":"962.182232ms","start":"2026-02-26T17:58:58.793595Z","end":"2026-02-26T17:58:59.755778Z","steps":["trace[614957669] 'agreement among raft nodes before linearized reading' (duration: 961.408915ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:59.755804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:58.796738Z","time spent":"959.056662ms","remote":"127.0.0.1:53448","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-26T17:58:59.755814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:58.793589Z","time spent":"962.217902ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-26T17:58:59.857332Z","caller":"traceutil/trace.go:171","msg":"trace[1420660279] linearizableReadLoop","detail":"{readStateIndex:976; appliedIndex:974; }","duration":"102.368266ms","start":"2026-02-26T17:58:59.754941Z","end":"2026-02-26T17:58:59.857309Z","steps":["trace[1420660279] 'read index received' (duration: 83.523258ms)","trace[1420660279] 'applied index is now lower than readState.Index' (duration: 18.844148ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:58:59.857442Z","caller":"traceutil/trace.go:171","msg":"trace[451107977] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"153.253747ms","start":"2026-02-26T17:58:59.704174Z","end":"2026-02-26T17:58:59.857428Z","steps":["trace[451107977] 'process raft request' (duration: 153.054152ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:59.857531Z","caller":"traceutil/trace.go:171","msg":"trace[675397125] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"153.311888ms","start":"2026-02-26T17:58:59.704048Z","end":"2026-02-26T17:58:59.85736Z","steps":["trace[675397125] 'process raft request' (duration: 134.404098ms)","trace[675397125] 'compare' (duration: 18.535522ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:58:59.858032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.377555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-02-26T17:58:59.858086Z","caller":"traceutil/trace.go:171","msg":"trace[1965170377] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:937; }","duration":"155.478357ms","start":"2026-02-26T17:58:59.702595Z","end":"2026-02-26T17:58:59.858073Z","steps":["trace[1965170377] 'agreement among raft nodes before linearized reading' (duration: 155.150419ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:59.881948Z","caller":"traceutil/trace.go:171","msg":"trace[1288930401] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"122.29799ms","start":"2026-02-26T17:58:59.759633Z","end":"2026-02-26T17:58:59.881931Z","steps":["trace[1288930401] 'process raft request' (duration: 122.137056ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:59.882295Z","caller":"traceutil/trace.go:171","msg":"trace[844826115] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"122.485362ms","start":"2026-02-26T17:58:59.759791Z","end":"2026-02-26T17:58:59.882276Z","steps":["trace[844826115] 'process raft request' (duration: 122.090484ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:59.88238Z","caller":"traceutil/trace.go:171","msg":"trace[1918275076] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"121.884289ms","start":"2026-02-26T17:58:59.760449Z","end":"2026-02-26T17:58:59.882333Z","steps":["trace[1918275076] 'process raft request' (duration: 121.660205ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:59.88257Z","caller":"traceutil/trace.go:171","msg":"trace[318258179] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"121.091862ms","start":"2026-02-26T17:58:59.761462Z","end":"2026-02-26T17:58:59.882554Z","steps":["trace[318258179] 'process raft request' (duration: 120.815946ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:59.882647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.447158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:58:59.883131Z","caller":"traceutil/trace.go:171","msg":"trace[1844934483] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:941; }","duration":"125.991551ms","start":"2026-02-26T17:58:59.757121Z","end":"2026-02-26T17:58:59.883112Z","steps":["trace[1844934483] 'agreement among raft nodes before linearized reading' (duration: 125.388537ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:59.882638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.229831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-02-26T17:58:59.883294Z","caller":"traceutil/trace.go:171","msg":"trace[2130771292] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:941; }","duration":"124.924108ms","start":"2026-02-26T17:58:59.758353Z","end":"2026-02-26T17:58:59.883277Z","steps":["trace[2130771292] 'agreement among raft nodes before linearized reading' (duration: 124.211811ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:59:02.41432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.051937ms","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-26T17:59:02.414399Z","caller":"traceutil/trace.go:171","msg":"trace[25726241] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:948; }","duration":"370.1398ms","start":"2026-02-26T17:59:02.044241Z","end":"2026-02-26T17:59:02.414381Z","steps":["trace[25726241] 'range keys from in-memory index tree' (duration: 369.821842ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:59:02.41444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:59:02.044173Z","time spent":"370.257582ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-26T17:59:06.442624Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471724564009367425,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-26T17:59:06.444151Z","caller":"traceutil/trace.go:171","msg":"trace[726578499] linearizableReadLoop","detail":"{readStateIndex:1012; appliedIndex:1011; }","duration":"502.178705ms","start":"2026-02-26T17:59:05.941951Z","end":"2026-02-26T17:59:06.444129Z","steps":["trace[726578499] 'read index received' (duration: 502.017952ms)","trace[726578499] 'applied index is now lower than readState.Index' (duration: 160.183µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:59:06.444229Z","caller":"traceutil/trace.go:171","msg":"trace[1880650092] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"526.474085ms","start":"2026-02-26T17:59:05.917748Z","end":"2026-02-26T17:59:06.444222Z","steps":["trace[1880650092] 'process raft request' (duration: 526.22144ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:59:06.444329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:59:05.91772Z","time spent":"526.524996ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T17:59:06.444678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.042403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:59:06.444711Z","caller":"traceutil/trace.go:171","msg":"trace[1145465383] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:972; }","duration":"108.135625ms","start":"2026-02-26T17:59:06.336568Z","end":"2026-02-26T17:59:06.444704Z","steps":["trace[1145465383] 'agreement among raft nodes before linearized reading' (duration: 108.080133ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:59:06.444649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.116604ms","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-26T17:59:06.444855Z","caller":"traceutil/trace.go:171","msg":"trace[1728533352] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:972; }","duration":"484.264086ms","start":"2026-02-26T17:59:05.960471Z","end":"2026-02-26T17:59:06.444735Z","steps":["trace[1728533352] 'agreement among raft nodes before linearized reading' (duration: 483.98575ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:59:06.444934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:59:05.960457Z","time spent":"484.45729ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-26T17:59:06.445003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.022934ms","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":"warn","ts":"2026-02-26T17:59:06.445066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.705244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:59:06.445128Z","caller":"traceutil/trace.go:171","msg":"trace[2008258137] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:972; }","duration":"503.191168ms","start":"2026-02-26T17:59:05.941917Z","end":"2026-02-26T17:59:06.445108Z","steps":["trace[2008258137] 'agreement among raft nodes before linearized reading' (duration: 502.774328ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:59:06.445179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.99161ms","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-26T17:59:06.445285Z","caller":"traceutil/trace.go:171","msg":"trace[1027759560] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:972; }","duration":"484.139304ms","start":"2026-02-26T17:59:05.961123Z","end":"2026-02-26T17:59:06.445263Z","steps":["trace[1027759560] 'agreement among raft nodes before linearized reading' (duration: 483.836357ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:59:06.445335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:59:05.961111Z","time spent":"484.215155ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-26T17:59:06.445569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:59:05.941904Z","time spent":"503.342511ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-26T17:59:06.446073Z","caller":"traceutil/trace.go:171","msg":"trace[1036486748] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:972; }","duration":"147.932099ms","start":"2026-02-26T17:59:06.297241Z","end":"2026-02-26T17:59:06.445173Z","steps":["trace[1036486748] 'agreement among raft nodes before linearized reading' (duration: 147.650893ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:59:06.785776Z","caller":"traceutil/trace.go:171","msg":"trace[1668913027] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"335.214503ms","start":"2026-02-26T17:59:06.450538Z","end":"2026-02-26T17:59:06.785753Z","steps":["trace[1668913027] 'process raft request' (duration: 335.099541ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:59:06.785803Z","caller":"traceutil/trace.go:171","msg":"trace[273268994] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"335.370476ms","start":"2026-02-26T17:59:06.450401Z","end":"2026-02-26T17:59:06.785771Z","steps":["trace[273268994] 'process raft request' (duration: 304.976751ms)","trace[273268994] 'compare' (duration: 30.115528ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:59:06.785936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:59:06.450372Z","time spent":"335.491328ms","remote":"127.0.0.1:53710","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-26T17:59:06.786108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:59:06.450516Z","time spent":"335.332635ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T17:59:06.786293Z","caller":"traceutil/trace.go:171","msg":"trace[1682030465] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"335.653162ms","start":"2026-02-26T17:59:06.450599Z","end":"2026-02-26T17:59:06.786252Z","steps":["trace[1682030465] 'process raft request' (duration: 335.11806ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:59:06.786284Z","caller":"traceutil/trace.go:171","msg":"trace[2041523051] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"335.392707ms","start":"2026-02-26T17:59:06.450864Z","end":"2026-02-26T17:59:06.786257Z","steps":["trace[2041523051] 'process raft request' (duration: 335.267294ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:59:06.786384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:59:06.450592Z","time spent":"335.741935ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T17:59:06.786467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:59:06.450847Z","time spent":"335.507489ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T17:59:07.927301Z","caller":"traceutil/trace.go:171","msg":"trace[791848669] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"102.201212ms","start":"2026-02-26T17:59:07.825075Z","end":"2026-02-26T17:59:07.927276Z","steps":["trace[791848669] 'process raft request' (duration: 52.65245ms)","trace[791848669] 'compare' (duration: 49.414509ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:59:21.337835Z","caller":"traceutil/trace.go:171","msg":"trace[1205224350] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"318.043991ms","start":"2026-02-26T17:59:21.019765Z","end":"2026-02-26T17:59:21.337809Z","steps":["trace[1205224350] 'process raft request' (duration: 268.791957ms)","trace[1205224350] 'compare' (duration: 48.809384ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:59:21.337988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:59:21.019756Z","time spent":"318.152123ms","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T18:00:27.207628Z","caller":"traceutil/trace.go:171","msg":"trace[1065640881] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"227.303389ms","start":"2026-02-26T18:00:26.980296Z","end":"2026-02-26T18:00:27.207599Z","steps":["trace[1065640881] 'process raft request' (duration: 227.134426ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:00:50.367703Z","caller":"traceutil/trace.go:171","msg":"trace[984811913] transaction","detail":"{read_only:false; response_revision:1415; number_of_response:1; }","duration":"179.255336ms","start":"2026-02-26T18:00:50.188421Z","end":"2026-02-26T18:00:50.367677Z","steps":["trace[984811913] 'process raft request' (duration: 179.084662ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:01:31.016642Z","caller":"traceutil/trace.go:171","msg":"trace[519144484] transaction","detail":"{read_only:false; response_revision:1580; number_of_response:1; }","duration":"108.065816ms","start":"2026-02-26T18:01:30.90854Z","end":"2026-02-26T18:01:31.016605Z","steps":["trace[519144484] 'process raft request' (duration: 107.832891ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:01:58.69156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.447434ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T18:01:58.691762Z","caller":"traceutil/trace.go:171","msg":"trace[1061832252] transaction","detail":"{read_only:false; response_revision:1694; number_of_response:1; }","duration":"183.344777ms","start":"2026-02-26T18:01:58.5084Z","end":"2026-02-26T18:01:58.691745Z","steps":["trace[1061832252] 'process raft request' (duration: 183.276685ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:01:58.691836Z","caller":"traceutil/trace.go:171","msg":"trace[1557257363] transaction","detail":"{read_only:false; response_revision:1693; number_of_response:1; }","duration":"186.660251ms","start":"2026-02-26T18:01:58.50512Z","end":"2026-02-26T18:01:58.69178Z","steps":["trace[1557257363] 'process raft request' (duration: 50.898569ms)","trace[1557257363] 'compare' (duration: 135.296071ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T18:02:00.437544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.209854ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T18:02:00.437712Z","caller":"traceutil/trace.go:171","msg":"trace[1268595701] linearizableReadLoop","detail":"{readStateIndex:1776; appliedIndex:1775; }","duration":"133.585943ms","start":"2026-02-26T18:02:00.304109Z","end":"2026-02-26T18:02:00.437695Z","steps":["trace[1268595701] 'read index received' (duration: 32.491µs)","trace[1268595701] 'applied index is now lower than readState.Index' (duration: 133.551862ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:02:00.437908Z","caller":"traceutil/trace.go:171","msg":"trace[1848975873] transaction","detail":"{read_only:false; response_revision:1701; number_of_response:1; }","duration":"274.928178ms","start":"2026-02-26T18:02:00.162941Z","end":"2026-02-26T18:02:00.437869Z","steps":["trace[1848975873] 'process raft request' (duration: 68.267814ms)","trace[1848975873] 'compare' (duration: 206.04114ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T18:02:00.437956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.847269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-26T18:02:00.438005Z","caller":"traceutil/trace.go:171","msg":"trace[1653834914] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1701; }","duration":"133.938281ms","start":"2026-02-26T18:02:00.304057Z","end":"2026-02-26T18:02:00.437995Z","steps":["trace[1653834914] 'agreement among raft nodes before linearized reading' (duration: 133.696475ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:02:28.134294Z","caller":"traceutil/trace.go:171","msg":"trace[492356502] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"265.899788ms","start":"2026-02-26T18:02:27.868355Z","end":"2026-02-26T18:02:28.134255Z","steps":["trace[492356502] 'process raft request' (duration: 265.562139ms)"],"step_count":1}