{"level":"warn","ts":"2026-02-25T19:25:17.938135Z","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-25T19:25:17.938269Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.134: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.19.213.134:2380","--initial-cluster=instance=https://199.19.213.134:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.134:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.134: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-25T19:25:17.938366Z","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-25T19:25:17.938387Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.134:2380"]} {"level":"info","ts":"2026-02-25T19:25:17.938411Z","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-25T19:25:17.939101Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.134:2379"]} {"level":"info","ts":"2026-02-25T19:25:17.939201Z","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.19.213.134:2380"],"listen-peer-urls":["https://199.19.213.134:2380"],"advertise-client-urls":["https://199.19.213.134:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.134:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.134: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-25T19:25:17.94316Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.617465ms"} {"level":"info","ts":"2026-02-25T19:25:17.949007Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"92da22d3868c86fb","cluster-id":"84450b28e935eb90"} {"level":"info","ts":"2026-02-25T19:25:17.949067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb switched to configuration voters=()"} {"level":"info","ts":"2026-02-25T19:25:17.949084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became follower at term 0"} {"level":"info","ts":"2026-02-25T19:25:17.949094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 92da22d3868c86fb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-25T19:25:17.949101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became follower at term 1"} {"level":"info","ts":"2026-02-25T19:25:17.949132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb switched to configuration voters=(10581808566351202043)"} {"level":"warn","ts":"2026-02-25T19:25:17.953672Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-25T19:25:17.955092Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-25T19:25:17.956293Z","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-25T19:25:17.95858Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"92da22d3868c86fb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-25T19:25:17.959156Z","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-25T19:25:17.959251Z","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-25T19:25:17.959265Z","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-25T19:25:17.959209Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"92da22d3868c86fb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-25T19:25:17.961669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb switched to configuration voters=(10581808566351202043)"} {"level":"info","ts":"2026-02-25T19:25:17.96198Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"84450b28e935eb90","local-member-id":"92da22d3868c86fb","added-peer-id":"92da22d3868c86fb","added-peer-peer-urls":["https://199.19.213.134:2380"]} {"level":"info","ts":"2026-02-25T19:25:17.965711Z","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-25T19:25:17.965768Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.134:2380"} {"level":"info","ts":"2026-02-25T19:25:17.965875Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.134:2380"} {"level":"info","ts":"2026-02-25T19:25:17.966138Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"92da22d3868c86fb","initial-advertise-peer-urls":["https://199.19.213.134:2380"],"listen-peer-urls":["https://199.19.213.134:2380"],"advertise-client-urls":["https://199.19.213.134:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.134:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-25T19:25:17.966175Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-25T19:25:18.250268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb is starting a new election at term 1"} {"level":"info","ts":"2026-02-25T19:25:18.2504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became pre-candidate at term 1"} {"level":"info","ts":"2026-02-25T19:25:18.250468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb received MsgPreVoteResp from 92da22d3868c86fb at term 1"} {"level":"info","ts":"2026-02-25T19:25:18.25052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became candidate at term 2"} {"level":"info","ts":"2026-02-25T19:25:18.25056Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb received MsgVoteResp from 92da22d3868c86fb at term 2"} {"level":"info","ts":"2026-02-25T19:25:18.250605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became leader at term 2"} {"level":"info","ts":"2026-02-25T19:25:18.250642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 92da22d3868c86fb elected leader 92da22d3868c86fb at term 2"} {"level":"info","ts":"2026-02-25T19:25:18.252621Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"92da22d3868c86fb","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.134:2379]}","request-path":"/0/members/92da22d3868c86fb/attributes","cluster-id":"84450b28e935eb90","publish-timeout":"7s"} {"level":"info","ts":"2026-02-25T19:25:18.252974Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T19:25:18.25311Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-25T19:25:18.253145Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-25T19:25:18.253118Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T19:25:18.25285Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T19:25:18.254835Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-25T19:25:18.256121Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.134:2379"} {"level":"info","ts":"2026-02-25T19:25:18.256683Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"84450b28e935eb90","local-member-id":"92da22d3868c86fb","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T19:25:18.25692Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T19:25:18.257246Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T19:25:23.620328Z","caller":"traceutil/trace.go:171","msg":"trace[391714169] transaction","detail":"{read_only:false; number_of_response:0; response_revision:289; }","duration":"228.310232ms","start":"2026-02-25T19:25:23.391995Z","end":"2026-02-25T19:25:23.620306Z","steps":["trace[391714169] 'process raft request' (duration: 225.369446ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:23.624274Z","caller":"traceutil/trace.go:171","msg":"trace[1725578471] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"205.313357ms","start":"2026-02-25T19:25:23.418932Z","end":"2026-02-25T19:25:23.624245Z","steps":["trace[1725578471] 'process raft request' (duration: 205.137096ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:23.624294Z","caller":"traceutil/trace.go:171","msg":"trace[1868201720] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"205.203666ms","start":"2026-02-25T19:25:23.419067Z","end":"2026-02-25T19:25:23.62427Z","steps":["trace[1868201720] 'process raft request' (duration: 205.063025ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:23.624304Z","caller":"traceutil/trace.go:171","msg":"trace[577873482] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"229.631474ms","start":"2026-02-25T19:25:23.394652Z","end":"2026-02-25T19:25:23.624283Z","steps":["trace[577873482] 'process raft request' (duration: 229.277961ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:23.62439Z","caller":"traceutil/trace.go:171","msg":"trace[1164739754] linearizableReadLoop","detail":"{readStateIndex:302; appliedIndex:295; }","duration":"202.995387ms","start":"2026-02-25T19:25:23.421371Z","end":"2026-02-25T19:25:23.624367Z","steps":["trace[1164739754] 'read index received' (duration: 196.009495ms)","trace[1164739754] 'applied index is now lower than readState.Index' (duration: 6.984742ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T19:25:23.624373Z","caller":"traceutil/trace.go:171","msg":"trace[1939095777] transaction","detail":"{read_only:false; number_of_response:0; response_revision:292; }","duration":"205.235898ms","start":"2026-02-25T19:25:23.419098Z","end":"2026-02-25T19:25:23.624334Z","steps":["trace[1939095777] 'process raft request' (duration: 205.062026ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:23.624428Z","caller":"traceutil/trace.go:171","msg":"trace[2006738296] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"205.144756ms","start":"2026-02-25T19:25:23.419219Z","end":"2026-02-25T19:25:23.624364Z","steps":["trace[2006738296] 'process raft request' (duration: 204.978104ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:23.6245Z","caller":"traceutil/trace.go:171","msg":"trace[869744897] transaction","detail":"{read_only:false; number_of_response:0; response_revision:293; }","duration":"204.602112ms","start":"2026-02-25T19:25:23.419857Z","end":"2026-02-25T19:25:23.62446Z","steps":["trace[869744897] 'process raft request' (duration: 204.407089ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:23.624596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.197109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-25T19:25:23.624691Z","caller":"traceutil/trace.go:171","msg":"trace[1660484384] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:294; }","duration":"203.312589ms","start":"2026-02-25T19:25:23.421366Z","end":"2026-02-25T19:25:23.624679Z","steps":["trace[1660484384] 'agreement among raft nodes before linearized reading' (duration: 203.109818ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:24.837815Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9726539989424603064,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-25T19:25:24.872051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.280913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-25T19:25:24.872115Z","caller":"traceutil/trace.go:171","msg":"trace[2049148379] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:306; }","duration":"800.397523ms","start":"2026-02-25T19:25:24.0717Z","end":"2026-02-25T19:25:24.872098Z","steps":["trace[2049148379] 'range keys from in-memory index tree' (duration: 800.183542ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:24.872152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:24.071665Z","time spent":"800.477496ms","remote":"127.0.0.1:49506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-02-25T19:25:24.872341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.592221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:25:24.872362Z","caller":"traceutil/trace.go:171","msg":"trace[617885604] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:306; }","duration":"795.650301ms","start":"2026-02-25T19:25:24.076705Z","end":"2026-02-25T19:25:24.872356Z","steps":["trace[617885604] 'range keys from in-memory index tree' (duration: 795.520271ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:24.87238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:24.076682Z","time spent":"795.692711ms","remote":"127.0.0.1:49680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-25T19:25:25.339065Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9726539989424603064,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-25T19:25:25.841144Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9726539989424603064,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-25T19:25:26.025742Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.689135826s","expected-duration":"1s"} {"level":"info","ts":"2026-02-25T19:25:26.026611Z","caller":"traceutil/trace.go:171","msg":"trace[1356854219] transaction","detail":"{read_only:false; number_of_response:0; response_revision:306; }","duration":"1.690104353s","start":"2026-02-25T19:25:24.33649Z","end":"2026-02-25T19:25:26.026594Z","steps":["trace[1356854219] 'process raft request' (duration: 1.690028322s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:26.026971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:24.336463Z","time spent":"1.690185484s","remote":"127.0.0.1:49584","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T19:25:26.705476Z","caller":"traceutil/trace.go:171","msg":"trace[1723876004] transaction","detail":"{read_only:false; number_of_response:0; response_revision:306; }","duration":"2.368786621s","start":"2026-02-25T19:25:24.336655Z","end":"2026-02-25T19:25:26.705441Z","steps":["trace[1723876004] 'process raft request' (duration: 2.368565238s)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:26.70554Z","caller":"traceutil/trace.go:171","msg":"trace[1353261610] transaction","detail":"{read_only:false; number_of_response:0; response_revision:306; }","duration":"2.3686767s","start":"2026-02-25T19:25:24.336833Z","end":"2026-02-25T19:25:26.705509Z","steps":["trace[1353261610] 'process raft request' (duration: 2.368502948s)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:26.70557Z","caller":"traceutil/trace.go:171","msg":"trace[954931130] linearizableReadLoop","detail":"{readStateIndex:321; appliedIndex:315; }","duration":"2.368416517s","start":"2026-02-25T19:25:24.337101Z","end":"2026-02-25T19:25:26.705518Z","steps":["trace[954931130] 'read index received' (duration: 1.689460488s)","trace[954931130] 'applied index is now lower than readState.Index' (duration: 678.954819ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T19:25:26.705638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:24.336623Z","time spent":"2.368946172s","remote":"127.0.0.1:49584","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T19:25:26.705694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:24.336814Z","time spent":"2.368808491s","remote":"127.0.0.1:49584","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T19:25:26.705494Z","caller":"traceutil/trace.go:171","msg":"trace[1641024532] transaction","detail":"{read_only:false; number_of_response:0; response_revision:306; }","duration":"2.36870468s","start":"2026-02-25T19:25:24.336746Z","end":"2026-02-25T19:25:26.705451Z","steps":["trace[1641024532] 'process raft request' (duration: 2.368562238s)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:26.70557Z","caller":"traceutil/trace.go:171","msg":"trace[544870011] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"1.822403902s","start":"2026-02-25T19:25:24.883151Z","end":"2026-02-25T19:25:26.705555Z","steps":["trace[544870011] 'process raft request' (duration: 1.822205389s)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:26.705861Z","caller":"traceutil/trace.go:171","msg":"trace[1229814911] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"1.82214509s","start":"2026-02-25T19:25:24.883699Z","end":"2026-02-25T19:25:26.705844Z","steps":["trace[1229814911] 'process raft request' (duration: 1.821755207s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:26.70591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:24.883677Z","time spent":"1.82220757s","remote":"127.0.0.1:49680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T19:25:26.705907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:24.883125Z","time spent":"1.822726114s","remote":"127.0.0.1:49602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":178,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T19:25:26.705931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.89456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"} {"level":"info","ts":"2026-02-25T19:25:26.70599Z","caller":"traceutil/trace.go:171","msg":"trace[644277682] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:308; }","duration":"677.973241ms","start":"2026-02-25T19:25:26.028002Z","end":"2026-02-25T19:25:26.705975Z","steps":["trace[644277682] 'agreement among raft nodes before linearized reading' (duration: 677.82895ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:26.706006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.145823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-02-25T19:25:26.706035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:26.027989Z","time spent":"678.034591ms","remote":"127.0.0.1:49584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":3490,"request content":"key:\"/registry/pods/kube-system/kube-vip-instance\" "} {"level":"warn","ts":"2026-02-25T19:25:26.706003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:24.336739Z","time spent":"2.369077063s","remote":"127.0.0.1:49584","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T19:25:26.706056Z","caller":"traceutil/trace.go:171","msg":"trace[42748954] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:308; }","duration":"750.222713ms","start":"2026-02-25T19:25:25.955817Z","end":"2026-02-25T19:25:26.70604Z","steps":["trace[42748954] 'agreement among raft nodes before linearized reading' (duration: 750.148473ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:26.705931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.277650394s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-02-25T19:25:26.70612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.369007212s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5511"} {"level":"info","ts":"2026-02-25T19:25:26.706144Z","caller":"traceutil/trace.go:171","msg":"trace[193829168] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:308; }","duration":"2.277900497s","start":"2026-02-25T19:25:24.428229Z","end":"2026-02-25T19:25:26.70613Z","steps":["trace[193829168] 'agreement among raft nodes before linearized reading' (duration: 2.277571663s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:26.706163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.114653525s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-25T19:25:26.706174Z","caller":"traceutil/trace.go:171","msg":"trace[1163375052] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:308; }","duration":"2.369171885s","start":"2026-02-25T19:25:24.336989Z","end":"2026-02-25T19:25:26.706161Z","steps":["trace[1163375052] 'agreement among raft nodes before linearized reading' (duration: 2.369021963s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:26.706192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:24.428211Z","time spent":"2.277966898s","remote":"127.0.0.1:49680","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-25T19:25:26.706208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:24.336965Z","time spent":"2.369237205s","remote":"127.0.0.1:49584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":5535,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"info","ts":"2026-02-25T19:25:26.706204Z","caller":"traceutil/trace.go:171","msg":"trace[1199187694] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:308; }","duration":"2.114771135s","start":"2026-02-25T19:25:24.59142Z","end":"2026-02-25T19:25:26.706191Z","steps":["trace[1199187694] 'agreement among raft nodes before linearized reading' (duration: 2.114705405s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:26.706245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:24.591392Z","time spent":"2.114842416s","remote":"127.0.0.1:49680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-25T19:25:26.706103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:25.955796Z","time spent":"750.294934ms","remote":"127.0.0.1:49680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-25T19:25:45.958464Z","caller":"traceutil/trace.go:171","msg":"trace[429221078] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"118.277353ms","start":"2026-02-25T19:25:45.840155Z","end":"2026-02-25T19:25:45.958433Z","steps":["trace[429221078] 'process raft request' (duration: 117.8395ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:46.334008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.532999ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-25T19:25:46.334108Z","caller":"traceutil/trace.go:171","msg":"trace[503080398] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"301.441338ms","start":"2026-02-25T19:25:46.032652Z","end":"2026-02-25T19:25:46.334093Z","steps":["trace[503080398] 'process raft request' (duration: 181.661777ms)","trace[503080398] 'compare' (duration: 119.346638ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T19:25:46.334336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:46.032623Z","time spent":"301.512799ms","remote":"127.0.0.1:49502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6516,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T19:25:46.611573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.05752ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-25T19:25:46.611856Z","caller":"traceutil/trace.go:171","msg":"trace[1749783600] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"270.173234ms","start":"2026-02-25T19:25:46.341669Z","end":"2026-02-25T19:25:46.611842Z","steps":["trace[1749783600] 'process raft request' (duration: 110.787041ms)","trace[1749783600] 'compare' (duration: 158.856238ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T19:25:46.611964Z","caller":"traceutil/trace.go:171","msg":"trace[1473586246] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"270.060793ms","start":"2026-02-25T19:25:46.341898Z","end":"2026-02-25T19:25:46.611959Z","steps":["trace[1473586246] 'process raft request' (duration: 269.764541ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:46.722332Z","caller":"traceutil/trace.go:171","msg":"trace[1099863520] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"105.005275ms","start":"2026-02-25T19:25:46.617306Z","end":"2026-02-25T19:25:46.722311Z","steps":["trace[1099863520] 'process raft request' (duration: 103.536033ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:46.944276Z","caller":"traceutil/trace.go:171","msg":"trace[1940703267] linearizableReadLoop","detail":"{readStateIndex:494; appliedIndex:493; }","duration":"137.377289ms","start":"2026-02-25T19:25:46.806871Z","end":"2026-02-25T19:25:46.944248Z","steps":["trace[1940703267] 'read index received' (duration: 68.135025ms)","trace[1940703267] 'applied index is now lower than readState.Index' (duration: 69.241014ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T19:25:46.944608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.406003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-25T19:25:46.944446Z","caller":"traceutil/trace.go:171","msg":"trace[1496634428] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"192.135341ms","start":"2026-02-25T19:25:46.752216Z","end":"2026-02-25T19:25:46.944351Z","steps":["trace[1496634428] 'process raft request' (duration: 122.824946ms)","trace[1496634428] 'compare' (duration: 69.072524ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T19:25:46.944666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.252252ms","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-25T19:25:46.944697Z","caller":"traceutil/trace.go:171","msg":"trace[2036439658] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:476; }","duration":"131.531173ms","start":"2026-02-25T19:25:46.813144Z","end":"2026-02-25T19:25:46.944676Z","steps":["trace[2036439658] 'agreement among raft nodes before linearized reading' (duration: 131.367242ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:46.944715Z","caller":"traceutil/trace.go:171","msg":"trace[1426533582] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:476; }","duration":"131.359632ms","start":"2026-02-25T19:25:46.81334Z","end":"2026-02-25T19:25:46.9447Z","steps":["trace[1426533582] 'agreement among raft nodes before linearized reading' (duration: 131.233052ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:46.944622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.014067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-02-25T19:25:46.944879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.008984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-25T19:25:46.944856Z","caller":"traceutil/trace.go:171","msg":"trace[106463145] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:476; }","duration":"128.260249ms","start":"2026-02-25T19:25:46.81657Z","end":"2026-02-25T19:25:46.944831Z","steps":["trace[106463145] 'agreement among raft nodes before linearized reading' (duration: 127.955186ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:46.944916Z","caller":"traceutil/trace.go:171","msg":"trace[85390087] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:476; }","duration":"138.075517ms","start":"2026-02-25T19:25:46.806827Z","end":"2026-02-25T19:25:46.944903Z","steps":["trace[85390087] 'agreement among raft nodes before linearized reading' (duration: 137.607943ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:47.113973Z","caller":"traceutil/trace.go:171","msg":"trace[1589482364] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"138.271163ms","start":"2026-02-25T19:25:46.975569Z","end":"2026-02-25T19:25:47.11384Z","steps":["trace[1589482364] 'process raft request' (duration: 91.107774ms)","trace[1589482364] 'compare' (duration: 46.720505ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T19:25:47.211402Z","caller":"traceutil/trace.go:171","msg":"trace[1585328613] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"178.041064ms","start":"2026-02-25T19:25:47.033307Z","end":"2026-02-25T19:25:47.211348Z","steps":["trace[1585328613] 'process raft request' (duration: 177.770612ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:47.211605Z","caller":"traceutil/trace.go:171","msg":"trace[1635340474] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"170.329144ms","start":"2026-02-25T19:25:47.041251Z","end":"2026-02-25T19:25:47.21158Z","steps":["trace[1635340474] 'process raft request' (duration: 170.011451ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:47.225551Z","caller":"traceutil/trace.go:171","msg":"trace[1077637355] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"101.214343ms","start":"2026-02-25T19:25:47.12432Z","end":"2026-02-25T19:25:47.225535Z","steps":["trace[1077637355] 'process raft request' (duration: 101.176162ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:47.225628Z","caller":"traceutil/trace.go:171","msg":"trace[1434271348] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"102.561193ms","start":"2026-02-25T19:25:47.123048Z","end":"2026-02-25T19:25:47.225609Z","steps":["trace[1434271348] 'process raft request' (duration: 102.417751ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:47.225751Z","caller":"traceutil/trace.go:171","msg":"trace[2135215540] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"102.761735ms","start":"2026-02-25T19:25:47.122984Z","end":"2026-02-25T19:25:47.225746Z","steps":["trace[2135215540] 'process raft request' (duration: 101.929349ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:47.482308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.17431ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T19:25:47.482733Z","caller":"traceutil/trace.go:171","msg":"trace[1929276146] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"256.361207ms","start":"2026-02-25T19:25:47.226337Z","end":"2026-02-25T19:25:47.482698Z","steps":["trace[1929276146] 'process raft request' (duration: 130.598802ms)","trace[1929276146] 'compare' (duration: 125.04756ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T19:25:47.483022Z","caller":"traceutil/trace.go:171","msg":"trace[1900812693] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"253.828517ms","start":"2026-02-25T19:25:47.229179Z","end":"2026-02-25T19:25:47.483007Z","steps":["trace[1900812693] 'process raft request' (duration: 253.484605ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:47.483118Z","caller":"traceutil/trace.go:171","msg":"trace[994151551] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"254.004038ms","start":"2026-02-25T19:25:47.229092Z","end":"2026-02-25T19:25:47.483096Z","steps":["trace[994151551] 'process raft request' (duration: 253.480044ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:47.483025Z","caller":"traceutil/trace.go:171","msg":"trace[695291728] linearizableReadLoop","detail":"{readStateIndex:513; appliedIndex:509; }","duration":"250.834884ms","start":"2026-02-25T19:25:47.231958Z","end":"2026-02-25T19:25:47.482792Z","steps":["trace[695291728] 'read index received' (duration: 73.160222ms)","trace[695291728] 'applied index is now lower than readState.Index' (duration: 177.671012ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T19:25:47.483233Z","caller":"traceutil/trace.go:171","msg":"trace[147834257] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"251.46534ms","start":"2026-02-25T19:25:47.231721Z","end":"2026-02-25T19:25:47.483186Z","steps":["trace[147834257] 'process raft request' (duration: 251.006796ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:47.483567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.59941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4335"} {"level":"info","ts":"2026-02-25T19:25:47.48365Z","caller":"traceutil/trace.go:171","msg":"trace[281108942] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:494; }","duration":"251.74348ms","start":"2026-02-25T19:25:47.231894Z","end":"2026-02-25T19:25:47.483638Z","steps":["trace[281108942] 'agreement among raft nodes before linearized reading' (duration: 251.421558ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:47.489646Z","caller":"traceutil/trace.go:171","msg":"trace[1530219252] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"178.863811ms","start":"2026-02-25T19:25:47.310757Z","end":"2026-02-25T19:25:47.489621Z","steps":["trace[1530219252] 'process raft request' (duration: 178.749211ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:47.489826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.497686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"} {"level":"info","ts":"2026-02-25T19:25:47.48989Z","caller":"traceutil/trace.go:171","msg":"trace[173187510] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:495; }","duration":"197.604537ms","start":"2026-02-25T19:25:47.292267Z","end":"2026-02-25T19:25:47.489872Z","steps":["trace[173187510] 'agreement among raft nodes before linearized reading' (duration: 197.340315ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:47.490051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.85544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qvt7w\" ","response":"range_response_count:1 size:15076"} {"level":"info","ts":"2026-02-25T19:25:47.490092Z","caller":"traceutil/trace.go:171","msg":"trace[296233730] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qvt7w; range_end:; response_count:1; response_revision:495; }","duration":"178.95491ms","start":"2026-02-25T19:25:47.311127Z","end":"2026-02-25T19:25:47.490082Z","steps":["trace[296233730] 'agreement among raft nodes before linearized reading' (duration: 178.795019ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:47.695555Z","caller":"traceutil/trace.go:171","msg":"trace[1394617496] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"184.490945ms","start":"2026-02-25T19:25:47.511045Z","end":"2026-02-25T19:25:47.695536Z","steps":["trace[1394617496] 'process raft request' (duration: 184.379255ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:47.695641Z","caller":"traceutil/trace.go:171","msg":"trace[1958829775] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"200.395819ms","start":"2026-02-25T19:25:47.495217Z","end":"2026-02-25T19:25:47.695613Z","steps":["trace[1958829775] 'process raft request' (duration: 186.624821ms)","trace[1958829775] 'compare' (duration: 13.446586ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T19:25:47.73755Z","caller":"traceutil/trace.go:171","msg":"trace[2001403446] linearizableReadLoop","detail":"{readStateIndex:518; appliedIndex:515; }","duration":"155.023504ms","start":"2026-02-25T19:25:47.582497Z","end":"2026-02-25T19:25:47.737521Z","steps":["trace[2001403446] 'read index received' (duration: 99.372848ms)","trace[2001403446] 'applied index is now lower than readState.Index' (duration: 55.648436ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T19:25:47.737717Z","caller":"traceutil/trace.go:171","msg":"trace[447803301] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"194.2578ms","start":"2026-02-25T19:25:47.543424Z","end":"2026-02-25T19:25:47.737682Z","steps":["trace[447803301] 'process raft request' (duration: 193.954798ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:47.737763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.224045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"} {"level":"info","ts":"2026-02-25T19:25:47.737806Z","caller":"traceutil/trace.go:171","msg":"trace[1915892647] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:499; }","duration":"155.339266ms","start":"2026-02-25T19:25:47.582456Z","end":"2026-02-25T19:25:47.737796Z","steps":["trace[1915892647] 'agreement among raft nodes before linearized reading' (duration: 155.214735ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:47.738045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.626632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"} {"level":"info","ts":"2026-02-25T19:25:47.738132Z","caller":"traceutil/trace.go:171","msg":"trace[1676687496] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:499; }","duration":"112.767183ms","start":"2026-02-25T19:25:47.625344Z","end":"2026-02-25T19:25:47.738111Z","steps":["trace[1676687496] 'agreement among raft nodes before linearized reading' (duration: 112.42974ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:50.844734Z","caller":"traceutil/trace.go:171","msg":"trace[1634732289] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"401.164686ms","start":"2026-02-25T19:25:50.443548Z","end":"2026-02-25T19:25:50.844713Z","steps":["trace[1634732289] 'process raft request' (duration: 401.047666ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:50.844863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:50.443523Z","time spent":"401.282107ms","remote":"127.0.0.1:55476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T19:25:50.844989Z","caller":"traceutil/trace.go:171","msg":"trace[1068509395] linearizableReadLoop","detail":"{readStateIndex:558; appliedIndex:558; }","duration":"265.713578ms","start":"2026-02-25T19:25:50.579246Z","end":"2026-02-25T19:25:50.84496Z","steps":["trace[1068509395] 'read index received' (duration: 265.703868ms)","trace[1068509395] 'applied index is now lower than readState.Index' (duration: 8.23µs)"],"step_count":2} {"level":"warn","ts":"2026-02-25T19:25:50.845106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.849029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:25:50.845179Z","caller":"traceutil/trace.go:171","msg":"trace[1551426981] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:539; }","duration":"265.950009ms","start":"2026-02-25T19:25:50.579219Z","end":"2026-02-25T19:25:50.845169Z","steps":["trace[1551426981] 'agreement among raft nodes before linearized reading' (duration: 265.822779ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:50.846195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.78554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:25:50.846234Z","caller":"traceutil/trace.go:171","msg":"trace[1520680508] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:540; }","duration":"202.85975ms","start":"2026-02-25T19:25:50.643364Z","end":"2026-02-25T19:25:50.846224Z","steps":["trace[1520680508] 'agreement among raft nodes before linearized reading' (duration: 202.768449ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:53.210959Z","caller":"traceutil/trace.go:171","msg":"trace[2011226880] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"133.830246ms","start":"2026-02-25T19:25:53.077087Z","end":"2026-02-25T19:25:53.210917Z","steps":["trace[2011226880] 'process raft request' (duration: 133.568525ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:53.216497Z","caller":"traceutil/trace.go:171","msg":"trace[1207927333] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"132.95203ms","start":"2026-02-25T19:25:53.083515Z","end":"2026-02-25T19:25:53.216467Z","steps":["trace[1207927333] 'process raft request' (duration: 132.710068ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:54.694522Z","caller":"traceutil/trace.go:171","msg":"trace[656147956] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"429.697788ms","start":"2026-02-25T19:25:54.264801Z","end":"2026-02-25T19:25:54.694499Z","steps":["trace[656147956] 'process raft request' (duration: 429.219866ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:54.694482Z","caller":"traceutil/trace.go:171","msg":"trace[1227504087] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"418.473973ms","start":"2026-02-25T19:25:54.275945Z","end":"2026-02-25T19:25:54.694419Z","steps":["trace[1227504087] 'read index received' (duration: 417.927207ms)","trace[1227504087] 'applied index is now lower than readState.Index' (duration: 545.236µs)"],"step_count":2} {"level":"warn","ts":"2026-02-25T19:25:54.694723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:54.264785Z","time spent":"429.826953ms","remote":"127.0.0.1:49572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4765,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T19:25:54.694728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.734715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:25:54.694819Z","caller":"traceutil/trace.go:171","msg":"trace[300577943] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:589; }","duration":"418.883643ms","start":"2026-02-25T19:25:54.275923Z","end":"2026-02-25T19:25:54.694807Z","steps":["trace[300577943] 'agreement among raft nodes before linearized reading' (duration: 418.649181ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:54.694902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:54.275911Z","time spent":"418.978468ms","remote":"127.0.0.1:47954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-02-25T19:25:54.698928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.867222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:25:54.698992Z","caller":"traceutil/trace.go:171","msg":"trace[1980201453] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:589; }","duration":"422.980459ms","start":"2026-02-25T19:25:54.275997Z","end":"2026-02-25T19:25:54.698978Z","steps":["trace[1980201453] 'agreement among raft nodes before linearized reading' (duration: 422.831961ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:54.699024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:54.275982Z","time spent":"423.036281ms","remote":"127.0.0.1:47954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:10000 "} {"level":"info","ts":"2026-02-25T19:25:54.699174Z","caller":"traceutil/trace.go:171","msg":"trace[1667413973] transaction","detail":"{read_only:false; number_of_response:1; response_revision:589; }","duration":"331.86762ms","start":"2026-02-25T19:25:54.367294Z","end":"2026-02-25T19:25:54.699162Z","steps":["trace[1667413973] 'process raft request' (duration: 331.44833ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:54.699259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:54.367273Z","time spent":"331.921803ms","remote":"127.0.0.1:49572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30,"response count":0,"response size":4814,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T19:25:54.699394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.270746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:25:54.699414Z","caller":"traceutil/trace.go:171","msg":"trace[1388359714] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:589; }","duration":"279.290857ms","start":"2026-02-25T19:25:54.420117Z","end":"2026-02-25T19:25:54.699408Z","steps":["trace[1388359714] 'agreement among raft nodes before linearized reading' (duration: 279.256615ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:54.699549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.952188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:25:54.69957Z","caller":"traceutil/trace.go:171","msg":"trace[2092829963] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:589; }","duration":"279.981669ms","start":"2026-02-25T19:25:54.419584Z","end":"2026-02-25T19:25:54.699566Z","steps":["trace[2092829963] 'agreement among raft nodes before linearized reading' (duration: 279.948347ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:54.699648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.092265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:25:54.699669Z","caller":"traceutil/trace.go:171","msg":"trace[1641394328] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:589; }","duration":"280.140568ms","start":"2026-02-25T19:25:54.419524Z","end":"2026-02-25T19:25:54.699665Z","steps":["trace[1641394328] 'agreement among raft nodes before linearized reading' (duration: 280.106027ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:54.699738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.125189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:25:54.699758Z","caller":"traceutil/trace.go:171","msg":"trace[1186971968] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:589; }","duration":"300.15972ms","start":"2026-02-25T19:25:54.399591Z","end":"2026-02-25T19:25:54.699751Z","steps":["trace[1186971968] 'agreement among raft nodes before linearized reading' (duration: 300.131249ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:54.699774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:54.39958Z","time spent":"300.188752ms","remote":"127.0.0.1:47974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 "} {"level":"warn","ts":"2026-02-25T19:25:54.699862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.614091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:25:54.699882Z","caller":"traceutil/trace.go:171","msg":"trace[1936818369] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:589; }","duration":"300.653314ms","start":"2026-02-25T19:25:54.399225Z","end":"2026-02-25T19:25:54.699878Z","steps":["trace[1936818369] 'agreement among raft nodes before linearized reading' (duration: 300.621723ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:54.699898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:54.399221Z","time spent":"300.673115ms","remote":"127.0.0.1:47974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-02-25T19:25:54.699971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.753299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:25:54.699992Z","caller":"traceutil/trace.go:171","msg":"trace[192376383] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:589; }","duration":"300.805161ms","start":"2026-02-25T19:25:54.399181Z","end":"2026-02-25T19:25:54.699986Z","steps":["trace[192376383] 'agreement among raft nodes before linearized reading' (duration: 300.77425ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:54.700008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:54.399167Z","time spent":"300.835723ms","remote":"127.0.0.1:47974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-02-25T19:25:54.700265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.638285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:25:54.700374Z","caller":"traceutil/trace.go:171","msg":"trace[577780907] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:589; }","duration":"328.814175ms","start":"2026-02-25T19:25:54.371532Z","end":"2026-02-25T19:25:54.700346Z","steps":["trace[577780907] 'agreement among raft nodes before linearized reading' (duration: 328.50577ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:54.700431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:54.371523Z","time spent":"328.895298ms","remote":"127.0.0.1:47968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-02-25T19:25:54.700451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.605805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:25:54.70048Z","caller":"traceutil/trace.go:171","msg":"trace[1354684050] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:589; }","duration":"328.650177ms","start":"2026-02-25T19:25:54.371823Z","end":"2026-02-25T19:25:54.700474Z","steps":["trace[1354684050] 'agreement among raft nodes before linearized reading' (duration: 328.607985ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:54.700501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:54.371818Z","time spent":"328.677258ms","remote":"127.0.0.1:47968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 "} {"level":"warn","ts":"2026-02-25T19:25:54.700558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.866367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:25:54.700662Z","caller":"traceutil/trace.go:171","msg":"trace[796776385] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:589; }","duration":"329.022004ms","start":"2026-02-25T19:25:54.371607Z","end":"2026-02-25T19:25:54.700629Z","steps":["trace[796776385] 'agreement among raft nodes before linearized reading' (duration: 328.841706ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:54.700718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:54.371591Z","time spent":"329.113618ms","remote":"127.0.0.1:47968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":113,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-02-25T19:25:54.700883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.835715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:25:54.700974Z","caller":"traceutil/trace.go:171","msg":"trace[1513112359] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:589; }","duration":"424.950421ms","start":"2026-02-25T19:25:54.275992Z","end":"2026-02-25T19:25:54.700943Z","steps":["trace[1513112359] 'agreement among raft nodes before linearized reading' (duration: 424.849277ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:54.701189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:54.275981Z","time spent":"425.040326ms","remote":"127.0.0.1:47954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:500 "} {"level":"info","ts":"2026-02-25T19:25:57.170383Z","caller":"traceutil/trace.go:171","msg":"trace[427326743] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:616; }","duration":"166.153494ms","start":"2026-02-25T19:25:57.004214Z","end":"2026-02-25T19:25:57.170368Z","steps":["trace[427326743] 'read index received' (duration: 164.695387ms)","trace[427326743] 'applied index is now lower than readState.Index' (duration: 1.457367ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T19:25:57.170532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.30108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-25T19:25:57.170549Z","caller":"traceutil/trace.go:171","msg":"trace[1365998626] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:595; }","duration":"166.357773ms","start":"2026-02-25T19:25:57.004186Z","end":"2026-02-25T19:25:57.170544Z","steps":["trace[1365998626] 'agreement among raft nodes before linearized reading' (duration: 166.261848ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:25:57.170624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.919502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-02-25T19:25:57.170641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.087724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-02-25T19:25:57.170646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.560818ms","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-25T19:25:57.170688Z","caller":"traceutil/trace.go:171","msg":"trace[1125031122] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:595; }","duration":"166.025027ms","start":"2026-02-25T19:25:57.004647Z","end":"2026-02-25T19:25:57.170672Z","steps":["trace[1125031122] 'agreement among raft nodes before linearized reading' (duration: 165.832669ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:57.170704Z","caller":"traceutil/trace.go:171","msg":"trace[1147535774] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:595; }","duration":"148.167757ms","start":"2026-02-25T19:25:57.022522Z","end":"2026-02-25T19:25:57.17069Z","steps":["trace[1147535774] 'agreement among raft nodes before linearized reading' (duration: 147.967658ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:25:57.170717Z","caller":"traceutil/trace.go:171","msg":"trace[168137990] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:595; }","duration":"157.653133ms","start":"2026-02-25T19:25:57.013047Z","end":"2026-02-25T19:25:57.1707Z","steps":["trace[168137990] 'agreement among raft nodes before linearized reading' (duration: 157.439883ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:27:09.725803Z","caller":"traceutil/trace.go:171","msg":"trace[156709605] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"190.779208ms","start":"2026-02-25T19:27:09.534998Z","end":"2026-02-25T19:27:09.725777Z","steps":["trace[156709605] 'process raft request' (duration: 190.592063ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:27:09.72667Z","caller":"traceutil/trace.go:171","msg":"trace[1898374466] linearizableReadLoop","detail":"{readStateIndex:954; appliedIndex:951; }","duration":"145.682951ms","start":"2026-02-25T19:27:09.580962Z","end":"2026-02-25T19:27:09.726644Z","steps":["trace[1898374466] 'read index received' (duration: 144.672868ms)","trace[1898374466] 'applied index is now lower than readState.Index' (duration: 1.008973ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T19:27:09.726941Z","caller":"traceutil/trace.go:171","msg":"trace[783305968] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"191.36496ms","start":"2026-02-25T19:27:09.53556Z","end":"2026-02-25T19:27:09.726925Z","steps":["trace[783305968] 'process raft request' (duration: 190.928861ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:27:09.727101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.12613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T19:27:09.727181Z","caller":"traceutil/trace.go:171","msg":"trace[1180260761] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:915; }","duration":"146.257714ms","start":"2026-02-25T19:27:09.580904Z","end":"2026-02-25T19:27:09.727161Z","steps":["trace[1180260761] 'agreement among raft nodes before linearized reading' (duration: 146.133671ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T19:27:09.727419Z","caller":"traceutil/trace.go:171","msg":"trace[44747673] transaction","detail":"{read_only:false; response_revision:915; number_of_response:1; }","duration":"191.81477ms","start":"2026-02-25T19:27:09.535588Z","end":"2026-02-25T19:27:09.727402Z","steps":["trace[44747673] 'process raft request' (duration: 191.017532ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T19:27:09.727684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.17559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-25T19:27:09.72774Z","caller":"traceutil/trace.go:171","msg":"trace[846230260] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:915; }","duration":"137.278192ms","start":"2026-02-25T19:27:09.590447Z","end":"2026-02-25T19:27:09.727725Z","steps":["trace[846230260] 'agreement among raft nodes before linearized reading' (duration: 137.039867ms)"],"step_count":1}