{"level":"warn","ts":"2026-02-12T18:02:14.350355Z","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-12T18:02:14.35045Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72: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.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72: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-12T18:02:14.350508Z","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-12T18:02:14.35053Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-02-12T18:02:14.350546Z","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-12T18:02:14.351435Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-02-12T18:02:14.351508Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72: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-12T18:02:14.355878Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.166862ms"} {"level":"info","ts":"2026-02-12T18:02:14.371832Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-02-12T18:02:14.371937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-02-12T18:02:14.371957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-02-12T18:02:14.371967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-12T18:02:14.371979Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-02-12T18:02:14.372027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-02-12T18:02:14.379415Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-12T18:02:14.381558Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-12T18:02:14.384253Z","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-12T18:02:14.390534Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-12T18:02:14.39582Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-12T18:02:14.396235Z","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-12T18:02:14.396295Z","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-12T18:02:14.396307Z","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-12T18:02:14.406092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-02-12T18:02:14.407104Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-02-12T18:02:14.407913Z","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-12T18:02:14.409476Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-02-12T18:02:14.409491Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-02-12T18:02:14.409651Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-12T18:02:14.409684Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-12T18:02:14.772644Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-02-12T18:02:14.77273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-02-12T18:02:14.772763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-02-12T18:02:14.77279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-02-12T18:02:14.772826Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-02-12T18:02:14.772844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-02-12T18:02:14.772865Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-02-12T18:02:14.774894Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-02-12T18:02:14.775045Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-12T18:02:14.774982Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-12T18:02:14.775499Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-12T18:02:14.775514Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-12T18:02:14.779407Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"info","ts":"2026-02-12T18:02:14.779682Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T18:02:14.795685Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-12T18:02:14.811953Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T18:02:14.812042Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T18:02:14.812083Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-02-12T18:02:19.380324Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680217815740442105,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-12T18:02:19.678601Z","caller":"traceutil/trace.go:171","msg":"trace[93347473] transaction","detail":"{read_only:false; response_revision:208; number_of_response:1; }","duration":"839.367065ms","start":"2026-02-12T18:02:18.839207Z","end":"2026-02-12T18:02:19.678574Z","steps":["trace[93347473] 'process raft request' (duration: 839.010376ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T18:02:19.679233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T18:02:18.839119Z","time spent":"839.563965ms","remote":"127.0.0.1:45422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T18:02:19.680617Z","caller":"traceutil/trace.go:171","msg":"trace[1262364266] linearizableReadLoop","detail":"{readStateIndex:215; appliedIndex:213; }","duration":"800.849912ms","start":"2026-02-12T18:02:18.879752Z","end":"2026-02-12T18:02:19.680602Z","steps":["trace[1262364266] 'read index received' (duration: 799.927632ms)","trace[1262364266] 'applied index is now lower than readState.Index' (duration: 921.53µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T18:02:19.68071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.962159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3179"} {"level":"info","ts":"2026-02-12T18:02:19.680758Z","caller":"traceutil/trace.go:171","msg":"trace[398390934] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:209; }","duration":"801.068644ms","start":"2026-02-12T18:02:18.87968Z","end":"2026-02-12T18:02:19.680749Z","steps":["trace[398390934] 'agreement among raft nodes before linearized reading' (duration: 800.98825ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T18:02:19.680794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T18:02:18.879625Z","time spent":"801.1612ms","remote":"127.0.0.1:45336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3201,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-02-12T18:02:19.680998Z","caller":"traceutil/trace.go:171","msg":"trace[1127170191] transaction","detail":"{read_only:false; response_revision:209; number_of_response:1; }","duration":"838.720411ms","start":"2026-02-12T18:02:18.842268Z","end":"2026-02-12T18:02:19.680988Z","steps":["trace[1127170191] 'process raft request' (duration: 838.217523ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T18:02:19.681068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T18:02:18.842245Z","time spent":"838.784974ms","remote":"127.0.0.1:45422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T18:02:19.681192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T18:02:19.136703Z","time spent":"544.487618ms","remote":"127.0.0.1:45226","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-12T18:02:30.200902Z","caller":"traceutil/trace.go:171","msg":"trace[2044143598] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"425.814838ms","start":"2026-02-12T18:02:29.775061Z","end":"2026-02-12T18:02:30.200876Z","steps":["trace[2044143598] 'process raft request' (duration: 425.67381ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T18:02:30.201171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T18:02:29.775054Z","time spent":"425.920774ms","remote":"127.0.0.1:45346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4049,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T18:02:30.201745Z","caller":"traceutil/trace.go:171","msg":"trace[1690347971] linearizableReadLoop","detail":"{readStateIndex:420; appliedIndex:420; }","duration":"426.559151ms","start":"2026-02-12T18:02:29.775174Z","end":"2026-02-12T18:02:30.201733Z","steps":["trace[1690347971] 'read index received' (duration: 426.554661ms)","trace[1690347971] 'applied index is now lower than readState.Index' (duration: 3.54µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T18:02:30.203812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.62719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-12T18:02:30.20387Z","caller":"traceutil/trace.go:171","msg":"trace[1468025574] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:410; }","duration":"428.737546ms","start":"2026-02-12T18:02:29.775117Z","end":"2026-02-12T18:02:30.203854Z","steps":["trace[1468025574] 'agreement among raft nodes before linearized reading' (duration: 426.686918ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T18:02:30.204015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T18:02:29.775106Z","time spent":"428.895025ms","remote":"127.0.0.1:45422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-12T18:02:30.246003Z","caller":"traceutil/trace.go:171","msg":"trace[399302312] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"468.235441ms","start":"2026-02-12T18:02:29.77774Z","end":"2026-02-12T18:02:30.245976Z","steps":["trace[399302312] 'process raft request' (duration: 461.142442ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T18:02:30.24629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.69825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4012"} {"level":"info","ts":"2026-02-12T18:02:30.246347Z","caller":"traceutil/trace.go:171","msg":"trace[1208126677] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:412; }","duration":"399.850678ms","start":"2026-02-12T18:02:29.846483Z","end":"2026-02-12T18:02:30.246334Z","steps":["trace[1208126677] 'agreement among raft nodes before linearized reading' (duration: 399.689879ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T18:02:30.246503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T18:02:29.846462Z","time spent":"400.027008ms","remote":"127.0.0.1:45336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4034,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-12T18:02:30.246679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T18:02:29.777691Z","time spent":"468.633964ms","remote":"127.0.0.1:45422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T18:02:30.443006Z","caller":"traceutil/trace.go:171","msg":"trace[490420213] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"182.87843ms","start":"2026-02-12T18:02:30.260094Z","end":"2026-02-12T18:02:30.442973Z","steps":["trace[490420213] 'process raft request' (duration: 113.588481ms)","trace[490420213] 'compare' (duration: 69.167102ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T18:02:30.841176Z","caller":"traceutil/trace.go:171","msg":"trace[490546057] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"107.84281ms","start":"2026-02-12T18:02:30.733317Z","end":"2026-02-12T18:02:30.84116Z","steps":["trace[490546057] 'process raft request' (duration: 107.748804ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:02:48.437002Z","caller":"traceutil/trace.go:171","msg":"trace[1357806252] linearizableReadLoop","detail":"{readStateIndex:561; appliedIndex:560; }","duration":"104.144348ms","start":"2026-02-12T18:02:48.332842Z","end":"2026-02-12T18:02:48.436986Z","steps":["trace[1357806252] 'read index received' (duration: 104.01042ms)","trace[1357806252] 'applied index is now lower than readState.Index' (duration: 133.378µs)"],"step_count":2} {"level":"info","ts":"2026-02-12T18:02:48.437072Z","caller":"traceutil/trace.go:171","msg":"trace[1033601142] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"108.615388ms","start":"2026-02-12T18:02:48.328452Z","end":"2026-02-12T18:02:48.437067Z","steps":["trace[1033601142] 'process raft request' (duration: 108.445707ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T18:02:48.437393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.537771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-12T18:02:48.437411Z","caller":"traceutil/trace.go:171","msg":"trace[1600744292] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:548; }","duration":"104.583654ms","start":"2026-02-12T18:02:48.332822Z","end":"2026-02-12T18:02:48.437406Z","steps":["trace[1600744292] 'agreement among raft nodes before linearized reading' (duration: 104.543582ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:02:49.298136Z","caller":"traceutil/trace.go:171","msg":"trace[1715981558] linearizableReadLoop","detail":"{readStateIndex:594; appliedIndex:593; }","duration":"119.585734ms","start":"2026-02-12T18:02:49.178536Z","end":"2026-02-12T18:02:49.298122Z","steps":["trace[1715981558] 'read index received' (duration: 112.114622ms)","trace[1715981558] 'applied index is now lower than readState.Index' (duration: 7.470282ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T18:02:49.298271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.717721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-02-12T18:02:49.298288Z","caller":"traceutil/trace.go:171","msg":"trace[1758002339] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:580; }","duration":"119.783595ms","start":"2026-02-12T18:02:49.178499Z","end":"2026-02-12T18:02:49.298283Z","steps":["trace[1758002339] 'agreement among raft nodes before linearized reading' (duration: 119.678429ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:02:49.298479Z","caller":"traceutil/trace.go:171","msg":"trace[939416985] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"142.870552ms","start":"2026-02-12T18:02:49.155602Z","end":"2026-02-12T18:02:49.298472Z","steps":["trace[939416985] 'process raft request' (duration: 135.021357ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:02:50.638379Z","caller":"traceutil/trace.go:171","msg":"trace[504471163] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"128.580512ms","start":"2026-02-12T18:02:50.509784Z","end":"2026-02-12T18:02:50.638364Z","steps":["trace[504471163] 'process raft request' (duration: 128.489156ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:02:50.64333Z","caller":"traceutil/trace.go:171","msg":"trace[743881488] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"132.352471ms","start":"2026-02-12T18:02:50.510965Z","end":"2026-02-12T18:02:50.643317Z","steps":["trace[743881488] 'process raft request' (duration: 131.856731ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:02:55.565297Z","caller":"traceutil/trace.go:171","msg":"trace[1847941845] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"167.212857ms","start":"2026-02-12T18:02:55.398066Z","end":"2026-02-12T18:02:55.565279Z","steps":["trace[1847941845] 'process raft request' (duration: 167.075988ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:02:55.565533Z","caller":"traceutil/trace.go:171","msg":"trace[338956109] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:628; }","duration":"159.501166ms","start":"2026-02-12T18:02:55.406026Z","end":"2026-02-12T18:02:55.565527Z","steps":["trace[338956109] 'read index received' (duration: 159.498416ms)","trace[338956109] 'applied index is now lower than readState.Index' (duration: 2.4µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T18:02:55.565639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.596642ms","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-12T18:02:55.565662Z","caller":"traceutil/trace.go:171","msg":"trace[82220649] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:613; }","duration":"159.641144ms","start":"2026-02-12T18:02:55.406016Z","end":"2026-02-12T18:02:55.565657Z","steps":["trace[82220649] 'agreement among raft nodes before linearized reading' (duration: 159.537297ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T18:02:55.882236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.235215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T18:02:55.882321Z","caller":"traceutil/trace.go:171","msg":"trace[1919715634] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:614; }","duration":"100.367113ms","start":"2026-02-12T18:02:55.781937Z","end":"2026-02-12T18:02:55.882304Z","steps":["trace[1919715634] 'range keys from in-memory index tree' (duration: 100.173911ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:03:01.000924Z","caller":"traceutil/trace.go:171","msg":"trace[1245951230] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"104.636448ms","start":"2026-02-12T18:03:00.896266Z","end":"2026-02-12T18:03:01.000902Z","steps":["trace[1245951230] 'process raft request' (duration: 104.49895ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:03:01.015797Z","caller":"traceutil/trace.go:171","msg":"trace[895749798] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"117.067154ms","start":"2026-02-12T18:03:00.898716Z","end":"2026-02-12T18:03:01.015783Z","steps":["trace[895749798] 'process raft request' (duration: 116.991419ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:03:07.757316Z","caller":"traceutil/trace.go:171","msg":"trace[243694344] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"105.192839ms","start":"2026-02-12T18:03:07.652108Z","end":"2026-02-12T18:03:07.757301Z","steps":["trace[243694344] 'process raft request' (duration: 104.819233ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:03:24.953541Z","caller":"traceutil/trace.go:171","msg":"trace[1508723905] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"134.546884ms","start":"2026-02-12T18:03:24.818978Z","end":"2026-02-12T18:03:24.953525Z","steps":["trace[1508723905] 'process raft request' (duration: 134.459695ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:03:24.954437Z","caller":"traceutil/trace.go:171","msg":"trace[945766073] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"133.871075ms","start":"2026-02-12T18:03:24.820559Z","end":"2026-02-12T18:03:24.95443Z","steps":["trace[945766073] 'process raft request' (duration: 133.762967ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T18:03:29.037297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.874713ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T18:03:29.037411Z","caller":"traceutil/trace.go:171","msg":"trace[2101491558] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:811; }","duration":"187.995931ms","start":"2026-02-12T18:03:28.849395Z","end":"2026-02-12T18:03:29.037391Z","steps":["trace[2101491558] 'range keys from in-memory index tree' (duration: 187.861913ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:03:29.302697Z","caller":"traceutil/trace.go:171","msg":"trace[342257975] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"260.430916ms","start":"2026-02-12T18:03:29.042238Z","end":"2026-02-12T18:03:29.302669Z","steps":["trace[342257975] 'process raft request' (duration: 260.289917ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:03:29.328638Z","caller":"traceutil/trace.go:171","msg":"trace[228618799] linearizableReadLoop","detail":"{readStateIndex:837; appliedIndex:836; }","duration":"263.916896ms","start":"2026-02-12T18:03:29.064703Z","end":"2026-02-12T18:03:29.32862Z","steps":["trace[228618799] 'read index received' (duration: 238.859037ms)","trace[228618799] 'applied index is now lower than readState.Index' (duration: 25.057189ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T18:03:29.32894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.214733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-12T18:03:29.329076Z","caller":"traceutil/trace.go:171","msg":"trace[1737390403] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:813; }","duration":"264.321872ms","start":"2026-02-12T18:03:29.064664Z","end":"2026-02-12T18:03:29.328986Z","steps":["trace[1737390403] 'agreement among raft nodes before linearized reading' (duration: 264.025306ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:03:29.329419Z","caller":"traceutil/trace.go:171","msg":"trace[701371104] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"285.232718ms","start":"2026-02-12T18:03:29.044174Z","end":"2026-02-12T18:03:29.329407Z","steps":["trace[701371104] 'process raft request' (duration: 284.333419ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:03:30.075351Z","caller":"traceutil/trace.go:171","msg":"trace[107062386] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"119.500024ms","start":"2026-02-12T18:03:29.955833Z","end":"2026-02-12T18:03:30.075333Z","steps":["trace[107062386] 'process raft request' (duration: 34.487304ms)","trace[107062386] 'compare' (duration: 84.794292ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T18:03:31.476863Z","caller":"traceutil/trace.go:171","msg":"trace[527746547] linearizableReadLoop","detail":"{readStateIndex:841; appliedIndex:840; }","duration":"143.825303ms","start":"2026-02-12T18:03:31.333016Z","end":"2026-02-12T18:03:31.476842Z","steps":["trace[527746547] 'read index received' (duration: 143.652565ms)","trace[527746547] 'applied index is now lower than readState.Index' (duration: 171.818µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T18:03:31.477062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.021731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-12T18:03:31.477092Z","caller":"traceutil/trace.go:171","msg":"trace[1379913255] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:817; }","duration":"144.091151ms","start":"2026-02-12T18:03:31.332991Z","end":"2026-02-12T18:03:31.477082Z","steps":["trace[1379913255] 'agreement among raft nodes before linearized reading' (duration: 143.934033ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:03:31.47738Z","caller":"traceutil/trace.go:171","msg":"trace[1487758170] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"167.463005ms","start":"2026-02-12T18:03:31.309906Z","end":"2026-02-12T18:03:31.477369Z","steps":["trace[1487758170] 'process raft request' (duration: 166.818781ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:03:31.628397Z","caller":"traceutil/trace.go:171","msg":"trace[1990953627] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"145.089052ms","start":"2026-02-12T18:03:31.483283Z","end":"2026-02-12T18:03:31.628372Z","steps":["trace[1990953627] 'process raft request' (duration: 66.971072ms)","trace[1990953627] 'compare' (duration: 77.958851ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T18:03:33.699171Z","caller":"traceutil/trace.go:171","msg":"trace[454261769] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"214.259822ms","start":"2026-02-12T18:03:33.484884Z","end":"2026-02-12T18:03:33.699143Z","steps":["trace[454261769] 'process raft request' (duration: 214.114323ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:03:33.777497Z","caller":"traceutil/trace.go:171","msg":"trace[1025033498] linearizableReadLoop","detail":"{readStateIndex:848; appliedIndex:847; }","duration":"144.707121ms","start":"2026-02-12T18:03:33.632764Z","end":"2026-02-12T18:03:33.777471Z","steps":["trace[1025033498] 'read index received' (duration: 66.868011ms)","trace[1025033498] 'applied index is now lower than readState.Index' (duration: 77.83767ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T18:03:33.777739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.96822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-12T18:03:33.77777Z","caller":"traceutil/trace.go:171","msg":"trace[1934205303] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:823; }","duration":"145.049868ms","start":"2026-02-12T18:03:33.63271Z","end":"2026-02-12T18:03:33.77776Z","steps":["trace[1934205303] 'agreement among raft nodes before linearized reading' (duration: 144.904169ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T18:03:33.777933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.199437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-12T18:03:33.777965Z","caller":"traceutil/trace.go:171","msg":"trace[1934899747] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:823; }","duration":"130.263777ms","start":"2026-02-12T18:03:33.647692Z","end":"2026-02-12T18:03:33.777955Z","steps":["trace[1934899747] 'agreement among raft nodes before linearized reading' (duration: 130.201097ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:03:34.12054Z","caller":"traceutil/trace.go:171","msg":"trace[1037934158] transaction","detail":"{read_only:false; response_revision:825; number_of_response:1; }","duration":"147.065833ms","start":"2026-02-12T18:03:33.973452Z","end":"2026-02-12T18:03:34.120517Z","steps":["trace[1037934158] 'process raft request' (duration: 146.566057ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:03:34.265362Z","caller":"traceutil/trace.go:171","msg":"trace[131258420] transaction","detail":"{read_only:false; response_revision:826; number_of_response:1; }","duration":"138.681884ms","start":"2026-02-12T18:03:34.126655Z","end":"2026-02-12T18:03:34.265337Z","steps":["trace[131258420] 'process raft request' (duration: 84.006963ms)","trace[131258420] 'compare' (duration: 54.576182ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T18:03:36.133876Z","caller":"traceutil/trace.go:171","msg":"trace[1315939529] transaction","detail":"{read_only:false; response_revision:829; number_of_response:1; }","duration":"258.545713ms","start":"2026-02-12T18:03:35.875312Z","end":"2026-02-12T18:03:36.133858Z","steps":["trace[1315939529] 'process raft request' (duration: 258.245085ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:03:38.333694Z","caller":"traceutil/trace.go:171","msg":"trace[613073183] transaction","detail":"{read_only:false; response_revision:835; number_of_response:1; }","duration":"149.379551ms","start":"2026-02-12T18:03:38.184298Z","end":"2026-02-12T18:03:38.333677Z","steps":["trace[613073183] 'process raft request' (duration: 149.048172ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:03:40.330382Z","caller":"traceutil/trace.go:171","msg":"trace[1417168734] transaction","detail":"{read_only:false; response_revision:841; number_of_response:1; }","duration":"158.986256ms","start":"2026-02-12T18:03:40.171361Z","end":"2026-02-12T18:03:40.330347Z","steps":["trace[1417168734] 'process raft request' (duration: 158.816936ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:03:42.557717Z","caller":"traceutil/trace.go:171","msg":"trace[2132932196] linearizableReadLoop","detail":"{readStateIndex:873; appliedIndex:872; }","duration":"176.089618ms","start":"2026-02-12T18:03:42.381611Z","end":"2026-02-12T18:03:42.5577Z","steps":["trace[2132932196] 'read index received' (duration: 130.740533ms)","trace[2132932196] 'applied index is now lower than readState.Index' (duration: 45.348235ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T18:03:42.557834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.208368ms","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-12T18:03:42.557855Z","caller":"traceutil/trace.go:171","msg":"trace[1183717625] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:847; }","duration":"176.252068ms","start":"2026-02-12T18:03:42.381594Z","end":"2026-02-12T18:03:42.557846Z","steps":["trace[1183717625] 'agreement among raft nodes before linearized reading' (duration: 176.162898ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:03:42.557869Z","caller":"traceutil/trace.go:171","msg":"trace[243072163] transaction","detail":"{read_only:false; response_revision:847; number_of_response:1; }","duration":"176.448248ms","start":"2026-02-12T18:03:42.381393Z","end":"2026-02-12T18:03:42.557841Z","steps":["trace[243072163] 'process raft request' (duration: 130.949843ms)","trace[243072163] 'compare' (duration: 45.290465ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T18:03:42.564449Z","caller":"traceutil/trace.go:171","msg":"trace[678384596] transaction","detail":"{read_only:false; response_revision:848; number_of_response:1; }","duration":"142.59507ms","start":"2026-02-12T18:03:42.421844Z","end":"2026-02-12T18:03:42.564439Z","steps":["trace[678384596] 'process raft request' (duration: 142.53107ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:04:10.87147Z","caller":"traceutil/trace.go:171","msg":"trace[168286602] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"121.241272ms","start":"2026-02-12T18:04:10.750207Z","end":"2026-02-12T18:04:10.871448Z","steps":["trace[168286602] 'process raft request' (duration: 121.10027ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:04:10.88196Z","caller":"traceutil/trace.go:171","msg":"trace[1532132048] linearizableReadLoop","detail":"{readStateIndex:980; appliedIndex:978; }","duration":"118.198564ms","start":"2026-02-12T18:04:10.763738Z","end":"2026-02-12T18:04:10.881936Z","steps":["trace[1532132048] 'read index received' (duration: 107.639224ms)","trace[1532132048] 'applied index is now lower than readState.Index' (duration: 10.55854ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T18:04:10.882158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.386258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-12T18:04:10.882212Z","caller":"traceutil/trace.go:171","msg":"trace[238610239] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:947; }","duration":"118.513881ms","start":"2026-02-12T18:04:10.76369Z","end":"2026-02-12T18:04:10.882204Z","steps":["trace[238610239] 'agreement among raft nodes before linearized reading' (duration: 118.382508ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:04:10.882502Z","caller":"traceutil/trace.go:171","msg":"trace[1905365068] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"130.307744ms","start":"2026-02-12T18:04:10.752185Z","end":"2026-02-12T18:04:10.882492Z","steps":["trace[1905365068] 'process raft request' (duration: 129.668672ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:04:22.876115Z","caller":"traceutil/trace.go:171","msg":"trace[1302388393] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"172.508464ms","start":"2026-02-12T18:04:22.703583Z","end":"2026-02-12T18:04:22.876091Z","steps":["trace[1302388393] 'process raft request' (duration: 172.377931ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:04:22.876712Z","caller":"traceutil/trace.go:171","msg":"trace[1922100692] linearizableReadLoop","detail":"{readStateIndex:1034; appliedIndex:1034; }","duration":"148.000398ms","start":"2026-02-12T18:04:22.728699Z","end":"2026-02-12T18:04:22.876699Z","steps":["trace[1922100692] 'read index received' (duration: 147.976318ms)","trace[1922100692] 'applied index is now lower than readState.Index' (duration: 23.09µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T18:04:22.876857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.165132ms","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-12T18:04:22.877122Z","caller":"traceutil/trace.go:171","msg":"trace[1108990999] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:998; }","duration":"148.435639ms","start":"2026-02-12T18:04:22.72867Z","end":"2026-02-12T18:04:22.877106Z","steps":["trace[1108990999] 'agreement among raft nodes before linearized reading' (duration: 148.087921ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T18:04:23.455731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.340607ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T18:04:23.455804Z","caller":"traceutil/trace.go:171","msg":"trace[1410439927] linearizableReadLoop","detail":"{readStateIndex:1035; appliedIndex:1034; }","duration":"525.673618ms","start":"2026-02-12T18:04:22.93012Z","end":"2026-02-12T18:04:23.455793Z","steps":["trace[1410439927] 'read index received' (duration: 96.101425ms)","trace[1410439927] 'applied index is now lower than readState.Index' (duration: 429.571093ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T18:04:23.456122Z","caller":"traceutil/trace.go:171","msg":"trace[2113919624] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"574.436043ms","start":"2026-02-12T18:04:22.881636Z","end":"2026-02-12T18:04:23.456072Z","steps":["trace[2113919624] 'process raft request' (duration: 144.602243ms)","trace[2113919624] 'compare' (duration: 429.247355ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T18:04:23.456192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T18:04:22.881618Z","time spent":"574.528406ms","remote":"127.0.0.1:45422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T18:04:23.456539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.420286ms","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-12T18:04:23.456566Z","caller":"traceutil/trace.go:171","msg":"trace[570152836] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:999; }","duration":"526.478278ms","start":"2026-02-12T18:04:22.930081Z","end":"2026-02-12T18:04:23.456559Z","steps":["trace[570152836] 'agreement among raft nodes before linearized reading' (duration: 526.378115ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T18:04:23.456666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T18:04:22.930065Z","time spent":"526.593251ms","remote":"127.0.0.1:45422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-12T18:04:23.45709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.837061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-12T18:04:23.45712Z","caller":"traceutil/trace.go:171","msg":"trace[1385687402] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:999; }","duration":"235.904923ms","start":"2026-02-12T18:04:23.221207Z","end":"2026-02-12T18:04:23.457112Z","steps":["trace[1385687402] 'agreement among raft nodes before linearized reading' (duration: 235.80531ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T18:04:23.457489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.202974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-12T18:04:23.457516Z","caller":"traceutil/trace.go:171","msg":"trace[1715427112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:999; }","duration":"163.258336ms","start":"2026-02-12T18:04:23.294251Z","end":"2026-02-12T18:04:23.45751Z","steps":["trace[1715427112] 'agreement among raft nodes before linearized reading' (duration: 163.188474ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T18:04:23.792939Z","caller":"traceutil/trace.go:171","msg":"trace[1649839186] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"227.903601ms","start":"2026-02-12T18:04:23.565017Z","end":"2026-02-12T18:04:23.79292Z","steps":["trace[1649839186] 'process raft request' (duration: 227.430269ms)"],"step_count":1}