{"level":"warn","ts":"2026-02-20T18:26:47.481574Z","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-20T18:26:47.481662Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205: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.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205: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-20T18:26:47.481731Z","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-20T18:26:47.481746Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-02-20T18:26:47.481764Z","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-20T18:26:47.482336Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]} {"level":"info","ts":"2026-02-20T18:26:47.482429Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205: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-20T18:26:47.486156Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.527488ms"} {"level":"info","ts":"2026-02-20T18:26:47.492452Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"} {"level":"info","ts":"2026-02-20T18:26:47.492542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"} {"level":"info","ts":"2026-02-20T18:26:47.492569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"} {"level":"info","ts":"2026-02-20T18:26:47.492583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-20T18:26:47.492623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"} {"level":"info","ts":"2026-02-20T18:26:47.492701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"warn","ts":"2026-02-20T18:26:47.506082Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-20T18:26:47.509207Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-20T18:26:47.510263Z","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-20T18:26:47.512634Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-20T18:26:47.512999Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-20T18:26:47.513104Z","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-20T18:26:47.513187Z","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-20T18:26:47.513199Z","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-20T18:26:47.519175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"info","ts":"2026-02-20T18:26:47.519465Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-02-20T18:26:47.536348Z","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-20T18:26:47.536583Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-02-20T18:26:47.537364Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-02-20T18:26:47.537745Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-20T18:26:47.537867Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-20T18:26:47.994271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"} {"level":"info","ts":"2026-02-20T18:26:47.994409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"} {"level":"info","ts":"2026-02-20T18:26:47.994608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"} {"level":"info","ts":"2026-02-20T18:26:47.994682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"} {"level":"info","ts":"2026-02-20T18:26:47.994742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-02-20T18:26:47.994808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"} {"level":"info","ts":"2026-02-20T18:26:47.994873Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-02-20T18:26:48.028398Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-20T18:26:48.033055Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"} {"level":"info","ts":"2026-02-20T18:26:48.03312Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-20T18:26:48.033204Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-20T18:26:48.033593Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-20T18:26:48.033747Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-20T18:26:48.036453Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-20T18:26:48.037776Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"} {"level":"info","ts":"2026-02-20T18:26:48.044071Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"} {"level":"info","ts":"2026-02-20T18:26:48.044338Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-20T18:26:48.044451Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-20T18:27:23.879552Z","caller":"traceutil/trace.go:171","msg":"trace[41375188] linearizableReadLoop","detail":"{readStateIndex:506; appliedIndex:505; }","duration":"255.231703ms","start":"2026-02-20T18:27:23.6243Z","end":"2026-02-20T18:27:23.879532Z","steps":["trace[41375188] 'read index received' (duration: 255.116801ms)","trace[41375188] 'applied index is now lower than readState.Index' (duration: 113.932µs)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:27:23.879678Z","caller":"traceutil/trace.go:171","msg":"trace[131218402] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"256.278743ms","start":"2026-02-20T18:27:23.623387Z","end":"2026-02-20T18:27:23.879665Z","steps":["trace[131218402] 'process raft request' (duration: 255.999758ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:27:23.879875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.5591ms","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-20T18:27:23.879939Z","caller":"traceutil/trace.go:171","msg":"trace[202022557] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:488; }","duration":"255.686752ms","start":"2026-02-20T18:27:23.624242Z","end":"2026-02-20T18:27:23.879929Z","steps":["trace[202022557] 'agreement among raft nodes before linearized reading' (duration: 255.537129ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:27:23.879939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.539319ms","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-20T18:27:23.879989Z","caller":"traceutil/trace.go:171","msg":"trace[1039949871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:488; }","duration":"255.623441ms","start":"2026-02-20T18:27:23.624353Z","end":"2026-02-20T18:27:23.879977Z","steps":["trace[1039949871] 'agreement among raft nodes before linearized reading' (duration: 255.453308ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:27:30.527651Z","caller":"traceutil/trace.go:171","msg":"trace[618603580] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:526; }","duration":"343.631713ms","start":"2026-02-20T18:27:30.183992Z","end":"2026-02-20T18:27:30.527623Z","steps":["trace[618603580] 'read index received' (duration: 343.388098ms)","trace[618603580] 'applied index is now lower than readState.Index' (duration: 242.575µs)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:27:30.527932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.881557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-lfrcl\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-20T18:27:30.527964Z","caller":"traceutil/trace.go:171","msg":"trace[2033944835] range","detail":"{range_begin:/registry/pods/kube-system/cilium-lfrcl; range_end:; response_count:1; response_revision:508; }","duration":"344.02981ms","start":"2026-02-20T18:27:30.183925Z","end":"2026-02-20T18:27:30.527955Z","steps":["trace[2033944835] 'agreement among raft nodes before linearized reading' (duration: 343.810136ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:27:30.527997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:27:30.183893Z","time spent":"344.098521ms","remote":"127.0.0.1:52754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16678,"request content":"key:\"/registry/pods/kube-system/cilium-lfrcl\" "} {"level":"info","ts":"2026-02-20T18:27:30.528291Z","caller":"traceutil/trace.go:171","msg":"trace[25125557] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"414.031659ms","start":"2026-02-20T18:27:30.114216Z","end":"2026-02-20T18:27:30.528247Z","steps":["trace[25125557] 'process raft request' (duration: 413.252884ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:27:30.529144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:27:30.114171Z","time spent":"414.215692ms","remote":"127.0.0.1:52832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-20T18:27:30.713478Z","caller":"traceutil/trace.go:171","msg":"trace[291634932] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"171.992134ms","start":"2026-02-20T18:27:30.541459Z","end":"2026-02-20T18:27:30.713451Z","steps":["trace[291634932] 'process raft request' (duration: 171.2783ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:27:31.931709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.698229ms","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-20T18:27:31.931852Z","caller":"traceutil/trace.go:171","msg":"trace[446768057] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:509; }","duration":"101.860712ms","start":"2026-02-20T18:27:31.829973Z","end":"2026-02-20T18:27:31.931834Z","steps":["trace[446768057] 'range keys from in-memory index tree' (duration: 101.680889ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:27:31.931862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.104010214s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-20T18:27:31.931914Z","caller":"traceutil/trace.go:171","msg":"trace[2020037277] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:509; }","duration":"1.104118816s","start":"2026-02-20T18:27:30.827779Z","end":"2026-02-20T18:27:31.931898Z","steps":["trace[2020037277] 'range keys from in-memory index tree' (duration: 1.103880842s)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:27:31.931894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.300479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.205\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-20T18:27:31.932241Z","caller":"traceutil/trace.go:171","msg":"trace[583249526] range","detail":"{range_begin:/registry/masterleases/199.204.45.205; range_end:; response_count:1; response_revision:509; }","duration":"881.698807ms","start":"2026-02-20T18:27:31.050521Z","end":"2026-02-20T18:27:31.93222Z","steps":["trace[583249526] 'range keys from in-memory index tree' (duration: 881.144426ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:27:31.93233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:27:31.050498Z","time spent":"881.808479ms","remote":"127.0.0.1:52596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.205\" "} {"level":"warn","ts":"2026-02-20T18:27:31.931971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:27:30.827748Z","time spent":"1.104211379s","remote":"127.0.0.1:52560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-20T18:27:52.146173Z","caller":"traceutil/trace.go:171","msg":"trace[796711360] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"153.303222ms","start":"2026-02-20T18:27:51.992842Z","end":"2026-02-20T18:27:52.146145Z","steps":["trace[796711360] 'process raft request' (duration: 153.132548ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:27:52.932476Z","caller":"traceutil/trace.go:171","msg":"trace[777341088] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"782.720011ms","start":"2026-02-20T18:27:52.149738Z","end":"2026-02-20T18:27:52.932458Z","steps":["trace[777341088] 'process raft request' (duration: 782.619969ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:27:52.932584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:27:52.149721Z","time spent":"782.809102ms","remote":"127.0.0.1:52832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-20T18:27:52.947514Z","caller":"traceutil/trace.go:171","msg":"trace[2083160585] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"797.011738ms","start":"2026-02-20T18:27:52.150453Z","end":"2026-02-20T18:27:52.947464Z","steps":["trace[2083160585] 'process raft request' (duration: 796.890296ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:27:52.947709Z","caller":"traceutil/trace.go:171","msg":"trace[1769068783] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"797.13363ms","start":"2026-02-20T18:27:52.150553Z","end":"2026-02-20T18:27:52.947686Z","steps":["trace[1769068783] 'process raft request' (duration: 796.865425ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:27:52.947711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:27:52.150427Z","time spent":"797.15169ms","remote":"127.0.0.1:52832","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-20T18:27:52.947831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:27:52.150544Z","time spent":"797.228662ms","remote":"127.0.0.1:52832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-20T18:27:52.947838Z","caller":"traceutil/trace.go:171","msg":"trace[943259371] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"796.958606ms","start":"2026-02-20T18:27:52.150854Z","end":"2026-02-20T18:27:52.947813Z","steps":["trace[943259371] 'process raft request' (duration: 796.760563ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:27:52.947939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.399486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-20T18:27:52.948009Z","caller":"traceutil/trace.go:171","msg":"trace[1547970229] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:701; }","duration":"119.500879ms","start":"2026-02-20T18:27:52.82849Z","end":"2026-02-20T18:27:52.947991Z","steps":["trace[1547970229] 'agreement among raft nodes before linearized reading' (duration: 119.401147ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:27:52.947942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:27:52.150843Z","time spent":"797.047478ms","remote":"127.0.0.1:52832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-20T18:27:52.947837Z","caller":"traceutil/trace.go:171","msg":"trace[1589149021] linearizableReadLoop","detail":"{readStateIndex:727; appliedIndex:723; }","duration":"119.251204ms","start":"2026-02-20T18:27:52.828536Z","end":"2026-02-20T18:27:52.947787Z","steps":["trace[1589149021] 'read index received' (duration: 103.805505ms)","trace[1589149021] 'applied index is now lower than readState.Index' (duration: 15.444669ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:28:19.272249Z","caller":"traceutil/trace.go:171","msg":"trace[784970810] linearizableReadLoop","detail":"{readStateIndex:808; appliedIndex:807; }","duration":"123.565135ms","start":"2026-02-20T18:28:19.148659Z","end":"2026-02-20T18:28:19.272224Z","steps":["trace[784970810] 'read index received' (duration: 123.363611ms)","trace[784970810] 'applied index is now lower than readState.Index' (duration: 200.504µs)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:28:19.272361Z","caller":"traceutil/trace.go:171","msg":"trace[787152317] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"202.549564ms","start":"2026-02-20T18:28:19.069782Z","end":"2026-02-20T18:28:19.272332Z","steps":["trace[787152317] 'process raft request' (duration: 202.299139ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:28:19.272578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.822109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-20T18:28:19.272941Z","caller":"traceutil/trace.go:171","msg":"trace[1877541566] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:776; }","duration":"124.264367ms","start":"2026-02-20T18:28:19.148622Z","end":"2026-02-20T18:28:19.272886Z","steps":["trace[1877541566] 'agreement among raft nodes before linearized reading' (duration: 123.724197ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:28:19.620266Z","caller":"traceutil/trace.go:171","msg":"trace[1852731856] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"343.3462ms","start":"2026-02-20T18:28:19.276888Z","end":"2026-02-20T18:28:19.620234Z","steps":["trace[1852731856] 'process raft request' (duration: 305.774827ms)","trace[1852731856] 'compare' (duration: 37.287958ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:28:19.620448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:28:19.276864Z","time spent":"343.478152ms","remote":"127.0.0.1:52832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-20T18:28:19.754785Z","caller":"traceutil/trace.go:171","msg":"trace[697309456] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"477.465722ms","start":"2026-02-20T18:28:19.277291Z","end":"2026-02-20T18:28:19.754757Z","steps":["trace[697309456] 'process raft request' (duration: 469.569224ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:28:19.755052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:28:19.277277Z","time spent":"477.577965ms","remote":"127.0.0.1:52832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-20T18:28:19.755194Z","caller":"traceutil/trace.go:171","msg":"trace[474977877] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"477.536364ms","start":"2026-02-20T18:28:19.277362Z","end":"2026-02-20T18:28:19.754898Z","steps":["trace[474977877] 'process raft request' (duration: 475.124578ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:28:19.755348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:28:19.277355Z","time spent":"477.91068ms","remote":"127.0.0.1:52832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-20T18:28:32.943587Z","caller":"traceutil/trace.go:171","msg":"trace[84757472] linearizableReadLoop","detail":"{readStateIndex:904; appliedIndex:903; }","duration":"115.175668ms","start":"2026-02-20T18:28:32.828373Z","end":"2026-02-20T18:28:32.943549Z","steps":["trace[84757472] 'read index received' (duration: 115.031445ms)","trace[84757472] 'applied index is now lower than readState.Index' (duration: 143.303µs)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:28:32.943698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.30327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-20T18:28:32.943727Z","caller":"traceutil/trace.go:171","msg":"trace[816448742] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:867; }","duration":"115.376131ms","start":"2026-02-20T18:28:32.828341Z","end":"2026-02-20T18:28:32.943717Z","steps":["trace[816448742] 'agreement among raft nodes before linearized reading' (duration: 115.31001ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:28:32.943921Z","caller":"traceutil/trace.go:171","msg":"trace[523055970] transaction","detail":"{read_only:false; response_revision:867; number_of_response:1; }","duration":"540.978442ms","start":"2026-02-20T18:28:32.402907Z","end":"2026-02-20T18:28:32.943885Z","steps":["trace[523055970] 'process raft request' (duration: 540.519583ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:28:32.944069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:28:32.402897Z","time spent":"541.104205ms","remote":"127.0.0.1:52832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-20T18:28:33.507991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.884826ms","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-20T18:28:33.50809Z","caller":"traceutil/trace.go:171","msg":"trace[2134111738] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:867; }","duration":"167.035039ms","start":"2026-02-20T18:28:33.34103Z","end":"2026-02-20T18:28:33.508065Z","steps":["trace[2134111738] 'range keys from in-memory index tree' (duration: 166.674892ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:28:47.31984Z","caller":"traceutil/trace.go:171","msg":"trace[1439270133] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"284.330935ms","start":"2026-02-20T18:28:47.035482Z","end":"2026-02-20T18:28:47.319813Z","steps":["trace[1439270133] 'process raft request' (duration: 284.111491ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:28:47.807607Z","caller":"traceutil/trace.go:171","msg":"trace[1627014262] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"141.548654ms","start":"2026-02-20T18:28:47.666035Z","end":"2026-02-20T18:28:47.807584Z","steps":["trace[1627014262] 'process raft request' (duration: 141.428011ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:28:53.482125Z","caller":"traceutil/trace.go:171","msg":"trace[176061228] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"122.282389ms","start":"2026-02-20T18:28:53.35981Z","end":"2026-02-20T18:28:53.482092Z","steps":["trace[176061228] 'process raft request' (duration: 122.094406ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:28:53.895043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.025147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-20T18:28:53.895138Z","caller":"traceutil/trace.go:171","msg":"trace[1793282745] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:950; }","duration":"190.179761ms","start":"2026-02-20T18:28:53.704937Z","end":"2026-02-20T18:28:53.895117Z","steps":["trace[1793282745] 'count revisions from in-memory index tree' (duration: 189.907944ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:28:53.895246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.080735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-20T18:28:53.895347Z","caller":"traceutil/trace.go:171","msg":"trace[1003985977] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:950; }","duration":"120.221588ms","start":"2026-02-20T18:28:53.775102Z","end":"2026-02-20T18:28:53.895323Z","steps":["trace[1003985977] 'count revisions from in-memory index tree' (duration: 120.018034ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:28:55.90312Z","caller":"traceutil/trace.go:171","msg":"trace[1074147347] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"194.969862ms","start":"2026-02-20T18:28:55.708123Z","end":"2026-02-20T18:28:55.903093Z","steps":["trace[1074147347] 'process raft request' (duration: 194.797849ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:28:56.129061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.646031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-20T18:28:56.129098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.76791ms","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-20T18:28:56.129194Z","caller":"traceutil/trace.go:171","msg":"trace[1029070585] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:964; }","duration":"204.781324ms","start":"2026-02-20T18:28:55.924351Z","end":"2026-02-20T18:28:56.129132Z","steps":["trace[1029070585] 'range keys from in-memory index tree' (duration: 204.525319ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:28:56.129227Z","caller":"traceutil/trace.go:171","msg":"trace[1086315078] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:964; }","duration":"102.000074ms","start":"2026-02-20T18:28:56.027205Z","end":"2026-02-20T18:28:56.129205Z","steps":["trace[1086315078] 'range keys from in-memory index tree' (duration: 101.447263ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:28:56.288021Z","caller":"traceutil/trace.go:171","msg":"trace[794243977] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"154.508437ms","start":"2026-02-20T18:28:56.133483Z","end":"2026-02-20T18:28:56.287991Z","steps":["trace[794243977] 'process raft request' (duration: 97.853704ms)","trace[794243977] 'compare' (duration: 56.473248ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:28:56.288299Z","caller":"traceutil/trace.go:171","msg":"trace[1860900190] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"152.945176ms","start":"2026-02-20T18:28:56.135323Z","end":"2026-02-20T18:28:56.288268Z","steps":["trace[1860900190] 'process raft request' (duration: 152.62491ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:28:56.288476Z","caller":"traceutil/trace.go:171","msg":"trace[1809048290] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"151.656771ms","start":"2026-02-20T18:28:56.136794Z","end":"2026-02-20T18:28:56.28845Z","steps":["trace[1809048290] 'process raft request' (duration: 151.395376ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:28:56.478937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.554667ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-20T18:28:56.47902Z","caller":"traceutil/trace.go:171","msg":"trace[711123898] linearizableReadLoop","detail":"{readStateIndex:1010; appliedIndex:1006; }","duration":"273.874289ms","start":"2026-02-20T18:28:56.205132Z","end":"2026-02-20T18:28:56.479006Z","steps":["trace[711123898] 'read index received' (duration: 26.177789ms)","trace[711123898] 'applied index is now lower than readState.Index' (duration: 247.6953ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:28:56.479107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.972331ms","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-20T18:28:56.479127Z","caller":"traceutil/trace.go:171","msg":"trace[92044555] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:968; }","duration":"274.030461ms","start":"2026-02-20T18:28:56.205088Z","end":"2026-02-20T18:28:56.479119Z","steps":["trace[92044555] 'agreement among raft nodes before linearized reading' (duration: 273.98111ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:28:56.479176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.595178ms","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-20T18:28:56.479244Z","caller":"traceutil/trace.go:171","msg":"trace[167290642] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:968; }","duration":"226.68299ms","start":"2026-02-20T18:28:56.252542Z","end":"2026-02-20T18:28:56.479225Z","steps":["trace[167290642] 'agreement among raft nodes before linearized reading' (duration: 226.548227ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:29:01.986285Z","caller":"traceutil/trace.go:171","msg":"trace[1050289331] linearizableReadLoop","detail":"{readStateIndex:1051; appliedIndex:1050; }","duration":"217.846108ms","start":"2026-02-20T18:29:01.768371Z","end":"2026-02-20T18:29:01.986218Z","steps":["trace[1050289331] 'read index received' (duration: 217.4909ms)","trace[1050289331] 'applied index is now lower than readState.Index' (duration: 353.908µs)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:29:01.986581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.167464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-20T18:29:01.986682Z","caller":"traceutil/trace.go:171","msg":"trace[1488189690] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1008; }","duration":"218.330067ms","start":"2026-02-20T18:29:01.768329Z","end":"2026-02-20T18:29:01.986659Z","steps":["trace[1488189690] 'agreement among raft nodes before linearized reading' (duration: 218.070313ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:29:01.986763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.700354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-02-20T18:29:01.98682Z","caller":"traceutil/trace.go:171","msg":"trace[877719193] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1008; }","duration":"183.811646ms","start":"2026-02-20T18:29:01.802994Z","end":"2026-02-20T18:29:01.986806Z","steps":["trace[877719193] 'agreement among raft nodes before linearized reading' (duration: 183.433749ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:29:01.986754Z","caller":"traceutil/trace.go:171","msg":"trace[9410258] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"423.274825ms","start":"2026-02-20T18:29:01.563183Z","end":"2026-02-20T18:29:01.986458Z","steps":["trace[9410258] 'process raft request' (duration: 422.798536ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:29:01.987346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:29:01.563156Z","time spent":"423.912337ms","remote":"127.0.0.1:52832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-20T18:29:02.384825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.397328ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-20T18:29:02.385023Z","caller":"traceutil/trace.go:171","msg":"trace[2018590637] linearizableReadLoop","detail":"{readStateIndex:1053; appliedIndex:1052; }","duration":"169.020368ms","start":"2026-02-20T18:29:02.215927Z","end":"2026-02-20T18:29:02.384948Z","steps":["trace[2018590637] 'read index received' (duration: 22.282074ms)","trace[2018590637] 'applied index is now lower than readState.Index' (duration: 146.736464ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:29:02.385117Z","caller":"traceutil/trace.go:171","msg":"trace[1829974602] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"361.663166ms","start":"2026-02-20T18:29:02.023385Z","end":"2026-02-20T18:29:02.385048Z","steps":["trace[1829974602] 'process raft request' (duration: 214.940712ms)","trace[1829974602] 'compare' (duration: 146.136443ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:29:02.385444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.486017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-20T18:29:02.385495Z","caller":"traceutil/trace.go:171","msg":"trace[2115355443] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1010; }","duration":"169.612569ms","start":"2026-02-20T18:29:02.21587Z","end":"2026-02-20T18:29:02.385483Z","steps":["trace[2115355443] 'agreement among raft nodes before linearized reading' (duration: 169.364915ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:29:02.385443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-20T18:29:02.023358Z","time spent":"361.930752ms","remote":"127.0.0.1:52832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-20T18:29:43.472679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.572086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-20T18:29:43.472762Z","caller":"traceutil/trace.go:171","msg":"trace[1642519854] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1181; }","duration":"102.699558ms","start":"2026-02-20T18:29:43.370044Z","end":"2026-02-20T18:29:43.472744Z","steps":["trace[1642519854] 'count revisions from in-memory index tree' (duration: 102.497354ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:30:00.542191Z","caller":"traceutil/trace.go:171","msg":"trace[1458153429] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"104.040716ms","start":"2026-02-20T18:30:00.438119Z","end":"2026-02-20T18:30:00.54216Z","steps":["trace[1458153429] 'process raft request' (duration: 103.882003ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:30:13.071154Z","caller":"traceutil/trace.go:171","msg":"trace[223616386] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"103.974754ms","start":"2026-02-20T18:30:12.96714Z","end":"2026-02-20T18:30:13.071114Z","steps":["trace[223616386] 'process raft request' (duration: 72.055423ms)","trace[223616386] 'compare' (duration: 31.755448ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:30:15.205433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.867923ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-20T18:30:15.205644Z","caller":"traceutil/trace.go:171","msg":"trace[914415058] linearizableReadLoop","detail":"{readStateIndex:1366; appliedIndex:1364; }","duration":"244.526632ms","start":"2026-02-20T18:30:14.961097Z","end":"2026-02-20T18:30:15.205624Z","steps":["trace[914415058] 'read index received' (duration: 139.339023ms)","trace[914415058] 'applied index is now lower than readState.Index' (duration: 105.186059ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:30:15.205715Z","caller":"traceutil/trace.go:171","msg":"trace[1714380567] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"259.266733ms","start":"2026-02-20T18:30:14.946403Z","end":"2026-02-20T18:30:15.20567Z","steps":["trace[1714380567] 'process raft request' (duration: 259.136261ms)"],"step_count":1} {"level":"warn","ts":"2026-02-20T18:30:15.205935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.618681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"} {"level":"warn","ts":"2026-02-20T18:30:15.205942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.811948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-20T18:30:15.205977Z","caller":"traceutil/trace.go:171","msg":"trace[813249762] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1309; }","duration":"129.695802ms","start":"2026-02-20T18:30:15.076271Z","end":"2026-02-20T18:30:15.205967Z","steps":["trace[813249762] 'agreement among raft nodes before linearized reading' (duration: 129.501538ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:30:15.205985Z","caller":"traceutil/trace.go:171","msg":"trace[1405314973] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1309; }","duration":"244.9171ms","start":"2026-02-20T18:30:14.961058Z","end":"2026-02-20T18:30:15.205975Z","steps":["trace[1405314973] 'agreement among raft nodes before linearized reading' (duration: 244.674915ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:30:15.205701Z","caller":"traceutil/trace.go:171","msg":"trace[185670642] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"259.226562ms","start":"2026-02-20T18:30:14.946406Z","end":"2026-02-20T18:30:15.205633Z","steps":["trace[185670642] 'process raft request' (duration: 154.055114ms)","trace[185670642] 'compare' (duration: 104.72834ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:30:23.517579Z","caller":"traceutil/trace.go:171","msg":"trace[584987802] transaction","detail":"{read_only:false; response_revision:1342; number_of_response:1; }","duration":"157.001422ms","start":"2026-02-20T18:30:23.36053Z","end":"2026-02-20T18:30:23.517532Z","steps":["trace[584987802] 'process raft request' (duration: 103.722199ms)","trace[584987802] 'compare' (duration: 53.000398ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:30:23.517799Z","caller":"traceutil/trace.go:171","msg":"trace[1026788889] transaction","detail":"{read_only:false; response_revision:1343; number_of_response:1; }","duration":"155.85795ms","start":"2026-02-20T18:30:23.361912Z","end":"2026-02-20T18:30:23.51777Z","steps":["trace[1026788889] 'process raft request' (duration: 155.558974ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:30:25.662309Z","caller":"traceutil/trace.go:171","msg":"trace[1555824923] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"135.004177ms","start":"2026-02-20T18:30:25.527257Z","end":"2026-02-20T18:30:25.662261Z","steps":["trace[1555824923] 'process raft request' (duration: 117.964381ms)","trace[1555824923] 'compare' (duration: 16.674869ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:30:37.657983Z","caller":"traceutil/trace.go:171","msg":"trace[920109691] linearizableReadLoop","detail":"{readStateIndex:1460; appliedIndex:1459; }","duration":"152.833759ms","start":"2026-02-20T18:30:37.505112Z","end":"2026-02-20T18:30:37.657945Z","steps":["trace[920109691] 'read index received' (duration: 86.118821ms)","trace[920109691] 'applied index is now lower than readState.Index' (duration: 66.713468ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:30:37.65827Z","caller":"traceutil/trace.go:171","msg":"trace[899009060] transaction","detail":"{read_only:false; response_revision:1398; number_of_response:1; }","duration":"193.514684ms","start":"2026-02-20T18:30:37.464705Z","end":"2026-02-20T18:30:37.65822Z","steps":["trace[899009060] 'process raft request' (duration: 126.006409ms)","trace[899009060] 'compare' (duration: 67.090796ms)"],"step_count":2} {"level":"warn","ts":"2026-02-20T18:30:37.65831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.209388ms","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-20T18:30:37.658399Z","caller":"traceutil/trace.go:171","msg":"trace[2009882967] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1398; }","duration":"153.393591ms","start":"2026-02-20T18:30:37.504989Z","end":"2026-02-20T18:30:37.658383Z","steps":["trace[2009882967] 'agreement among raft nodes before linearized reading' (duration: 153.107306ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:30:47.850608Z","caller":"traceutil/trace.go:171","msg":"trace[1062855817] transaction","detail":"{read_only:false; response_revision:1440; number_of_response:1; }","duration":"105.499025ms","start":"2026-02-20T18:30:47.745053Z","end":"2026-02-20T18:30:47.850552Z","steps":["trace[1062855817] 'process raft request' (duration: 23.155038ms)","trace[1062855817] 'compare' (duration: 82.115802ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:31:47.325823Z","caller":"traceutil/trace.go:171","msg":"trace[2025554838] transaction","detail":"{read_only:false; response_revision:1682; number_of_response:1; }","duration":"149.716268ms","start":"2026-02-20T18:31:47.176074Z","end":"2026-02-20T18:31:47.325791Z","steps":["trace[2025554838] 'process raft request' (duration: 149.34119ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:31:48.0052Z","caller":"traceutil/trace.go:171","msg":"trace[1795891979] transaction","detail":"{read_only:false; response_revision:1685; number_of_response:1; }","duration":"111.983512ms","start":"2026-02-20T18:31:47.893184Z","end":"2026-02-20T18:31:48.005167Z","steps":["trace[1795891979] 'process raft request' (duration: 45.403637ms)","trace[1795891979] 'compare' (duration: 66.438202ms)"],"step_count":2} {"level":"info","ts":"2026-02-20T18:32:12.249202Z","caller":"traceutil/trace.go:171","msg":"trace[379226698] transaction","detail":"{read_only:false; response_revision:1809; number_of_response:1; }","duration":"123.826725ms","start":"2026-02-20T18:32:12.125345Z","end":"2026-02-20T18:32:12.249171Z","steps":["trace[379226698] 'process raft request' (duration: 123.61637ms)"],"step_count":1} {"level":"info","ts":"2026-02-20T18:32:18.077107Z","caller":"traceutil/trace.go:171","msg":"trace[1903425631] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"125.419085ms","start":"2026-02-20T18:32:17.951625Z","end":"2026-02-20T18:32:18.077044Z","steps":["trace[1903425631] 'process raft request' (duration: 47.756205ms)","trace[1903425631] 'compare' (duration: 77.488707ms)"],"step_count":2}