{"level":"warn","ts":"2026-02-25T01:38:19.155682Z","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-25T01:38:19.15578Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4: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.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4: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-25T01:38:19.155851Z","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-25T01:38:19.155859Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-02-25T01:38:19.155875Z","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-25T01:38:19.156551Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]} {"level":"info","ts":"2026-02-25T01:38:19.156625Z","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.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4: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-25T01:38:19.16061Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.788415ms"} {"level":"info","ts":"2026-02-25T01:38:19.1679Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"} {"level":"info","ts":"2026-02-25T01:38:19.167983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"} {"level":"info","ts":"2026-02-25T01:38:19.168027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"} {"level":"info","ts":"2026-02-25T01:38:19.168039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-25T01:38:19.168051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"} {"level":"info","ts":"2026-02-25T01:38:19.16809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"warn","ts":"2026-02-25T01:38:19.173183Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-25T01:38:19.174332Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-25T01:38:19.17543Z","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-25T01:38:19.177623Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-25T01:38:19.180477Z","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-25T01:38:19.180647Z","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-25T01:38:19.18066Z","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-25T01:38:19.180815Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-25T01:38:19.182174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"info","ts":"2026-02-25T01:38:19.182319Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-02-25T01:38:19.18235Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-02-25T01:38:19.182324Z","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-25T01:38:19.182375Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-02-25T01:38:19.182597Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-25T01:38:19.182638Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-25T01:38:19.66836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"} {"level":"info","ts":"2026-02-25T01:38:19.668453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"} {"level":"info","ts":"2026-02-25T01:38:19.668494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"} {"level":"info","ts":"2026-02-25T01:38:19.668515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"} {"level":"info","ts":"2026-02-25T01:38:19.668533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-02-25T01:38:19.668549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"} {"level":"info","ts":"2026-02-25T01:38:19.668562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-02-25T01:38:19.669583Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T01:38:19.670282Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"} {"level":"info","ts":"2026-02-25T01:38:19.670461Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T01:38:19.670547Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T01:38:19.670745Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T01:38:19.670655Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-25T01:38:19.670834Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-25T01:38:19.670865Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T01:38:19.670896Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T01:38:19.673963Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"} {"level":"info","ts":"2026-02-25T01:38:19.674178Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-25T01:38:21.231382Z","caller":"traceutil/trace.go:171","msg":"trace[1419373488] transaction","detail":"{read_only:false; response_revision:53; number_of_response:1; }","duration":"123.287666ms","start":"2026-02-25T01:38:21.107643Z","end":"2026-02-25T01:38:21.23093Z","steps":["trace[1419373488] 'process raft request' (duration: 123.121272ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:38:21.231894Z","caller":"traceutil/trace.go:171","msg":"trace[207950322] transaction","detail":"{read_only:false; response_revision:54; number_of_response:1; }","duration":"121.981554ms","start":"2026-02-25T01:38:21.109874Z","end":"2026-02-25T01:38:21.231855Z","steps":["trace[207950322] 'process raft request' (duration: 120.929808ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:38:21.232188Z","caller":"traceutil/trace.go:171","msg":"trace[1066966115] transaction","detail":"{read_only:false; response_revision:52; number_of_response:1; }","duration":"124.422785ms","start":"2026-02-25T01:38:21.107302Z","end":"2026-02-25T01:38:21.231724Z","steps":["trace[1066966115] 'process raft request' (duration: 112.642342ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:38:49.824358Z","caller":"traceutil/trace.go:171","msg":"trace[2133851473] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"143.401248ms","start":"2026-02-25T01:38:49.680921Z","end":"2026-02-25T01:38:49.824322Z","steps":["trace[2133851473] 'process raft request' (duration: 143.139321ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:38:50.017651Z","caller":"traceutil/trace.go:171","msg":"trace[1089576478] linearizableReadLoop","detail":"{readStateIndex:559; appliedIndex:558; }","duration":"141.176652ms","start":"2026-02-25T01:38:49.876435Z","end":"2026-02-25T01:38:50.017612Z","steps":["trace[1089576478] 'read index received' (duration: 91.496116ms)","trace[1089576478] 'applied index is now lower than readState.Index' (duration: 49.679426ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:38:50.017845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.353366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T01:38:50.017849Z","caller":"traceutil/trace.go:171","msg":"trace[16932858] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"164.45977ms","start":"2026-02-25T01:38:49.853326Z","end":"2026-02-25T01:38:50.017786Z","steps":["trace[16932858] 'process raft request' (duration: 114.57685ms)","trace[16932858] 'compare' (duration: 49.550702ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:38:50.017944Z","caller":"traceutil/trace.go:171","msg":"trace[1750488659] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:540; }","duration":"141.577832ms","start":"2026-02-25T01:38:49.87635Z","end":"2026-02-25T01:38:50.017927Z","steps":["trace[1750488659] 'agreement among raft nodes before linearized reading' (duration: 141.398497ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:38:52.479075Z","caller":"traceutil/trace.go:171","msg":"trace[1818968368] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"573.993366ms","start":"2026-02-25T01:38:51.905052Z","end":"2026-02-25T01:38:52.479046Z","steps":["trace[1818968368] 'process raft request' (duration: 573.813292ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:38:52.479787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:38:51.905022Z","time spent":"574.152661ms","remote":"127.0.0.1:58026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T01:38:52.483998Z","caller":"traceutil/trace.go:171","msg":"trace[964253920] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:572; }","duration":"229.843546ms","start":"2026-02-25T01:38:52.254137Z","end":"2026-02-25T01:38:52.48398Z","steps":["trace[964253920] 'read index received' (duration: 224.975255ms)","trace[964253920] 'applied index is now lower than readState.Index' (duration: 4.867611ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:38:52.484135Z","caller":"traceutil/trace.go:171","msg":"trace[981363910] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"346.56157ms","start":"2026-02-25T01:38:52.13756Z","end":"2026-02-25T01:38:52.484122Z","steps":["trace[981363910] 'process raft request' (duration: 346.328994ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:38:52.484473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:38:52.137535Z","time spent":"346.890958ms","remote":"127.0.0.1:58026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T01:38:52.48492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.654809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-02-25T01:38:52.48499Z","caller":"traceutil/trace.go:171","msg":"trace[1103174696] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:554; }","duration":"208.751912ms","start":"2026-02-25T01:38:52.276216Z","end":"2026-02-25T01:38:52.484968Z","steps":["trace[1103174696] 'agreement among raft nodes before linearized reading' (duration: 208.572397ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:38:52.485523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.372425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-25T01:38:52.486684Z","caller":"traceutil/trace.go:171","msg":"trace[603021093] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:554; }","duration":"231.500029ms","start":"2026-02-25T01:38:52.254077Z","end":"2026-02-25T01:38:52.485577Z","steps":["trace[603021093] 'agreement among raft nodes before linearized reading' (duration: 230.127774ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:38:56.683383Z","caller":"traceutil/trace.go:171","msg":"trace[375307692] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"135.92364ms","start":"2026-02-25T01:38:56.547435Z","end":"2026-02-25T01:38:56.683358Z","steps":["trace[375307692] 'process raft request' (duration: 114.174689ms)","trace[375307692] 'compare' (duration: 21.613117ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:38:57.653295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.937296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-02-25T01:38:57.653343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"825.409928ms","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-25T01:38:57.653379Z","caller":"traceutil/trace.go:171","msg":"trace[897436359] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:578; }","duration":"133.082049ms","start":"2026-02-25T01:38:57.520278Z","end":"2026-02-25T01:38:57.65336Z","steps":["trace[897436359] 'range keys from in-memory index tree' (duration: 132.731261ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:38:57.653409Z","caller":"traceutil/trace.go:171","msg":"trace[854053469] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:578; }","duration":"825.516251ms","start":"2026-02-25T01:38:56.827877Z","end":"2026-02-25T01:38:57.653393Z","steps":["trace[854053469] 'range keys from in-memory index tree' (duration: 825.231794ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:38:57.653446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:38:56.827819Z","time spent":"825.618964ms","remote":"127.0.0.1:58228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-25T01:39:15.852402Z","caller":"traceutil/trace.go:171","msg":"trace[563621688] linearizableReadLoop","detail":"{readStateIndex:743; appliedIndex:742; }","duration":"106.449898ms","start":"2026-02-25T01:39:15.745913Z","end":"2026-02-25T01:39:15.852363Z","steps":["trace[563621688] 'read index received' (duration: 106.302154ms)","trace[563621688] 'applied index is now lower than readState.Index' (duration: 146.884µs)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:39:15.852515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.585051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T01:39:15.852546Z","caller":"traceutil/trace.go:171","msg":"trace[1883864635] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:718; }","duration":"106.655903ms","start":"2026-02-25T01:39:15.745882Z","end":"2026-02-25T01:39:15.852537Z","steps":["trace[1883864635] 'agreement among raft nodes before linearized reading' (duration: 106.595392ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:39:15.853059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.006601ms","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-25T01:39:15.853114Z","caller":"traceutil/trace.go:171","msg":"trace[741368348] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:718; }","duration":"107.128484ms","start":"2026-02-25T01:39:15.745976Z","end":"2026-02-25T01:39:15.853104Z","steps":["trace[741368348] 'agreement among raft nodes before linearized reading' (duration: 106.57471ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:39:15.852471Z","caller":"traceutil/trace.go:171","msg":"trace[1985168116] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"290.743632ms","start":"2026-02-25T01:39:15.561701Z","end":"2026-02-25T01:39:15.852444Z","steps":["trace[1985168116] 'process raft request' (duration: 290.561327ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:39:16.390997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.936305ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T01:39:16.391201Z","caller":"traceutil/trace.go:171","msg":"trace[1614680270] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"534.711498ms","start":"2026-02-25T01:39:15.856458Z","end":"2026-02-25T01:39:16.391169Z","steps":["trace[1614680270] 'process raft request' (duration: 245.27197ms)","trace[1614680270] 'compare' (duration: 288.813622ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:39:16.391232Z","caller":"traceutil/trace.go:171","msg":"trace[1723699518] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"533.375104ms","start":"2026-02-25T01:39:15.857838Z","end":"2026-02-25T01:39:16.391213Z","steps":["trace[1723699518] 'process raft request' (duration: 533.326173ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:39:16.391438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:39:15.85644Z","time spent":"534.913482ms","remote":"127.0.0.1:58228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:39:16.391272Z","caller":"traceutil/trace.go:171","msg":"trace[1789771990] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"534.725418ms","start":"2026-02-25T01:39:15.856538Z","end":"2026-02-25T01:39:16.391263Z","steps":["trace[1789771990] 'process raft request' (duration: 534.570454ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:39:16.391564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:39:15.857825Z","time spent":"533.64464ms","remote":"127.0.0.1:58228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:39:16.391643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:39:15.856515Z","time spent":"535.084567ms","remote":"127.0.0.1:58228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:39:16.895361Z","caller":"traceutil/trace.go:171","msg":"trace[756206061] linearizableReadLoop","detail":"{readStateIndex:747; appliedIndex:746; }","duration":"255.475014ms","start":"2026-02-25T01:39:16.639865Z","end":"2026-02-25T01:39:16.89534Z","steps":["trace[756206061] 'read index received' (duration: 255.207497ms)","trace[756206061] 'applied index is now lower than readState.Index' (duration: 266.587µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:39:16.895462Z","caller":"traceutil/trace.go:171","msg":"trace[133817693] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"273.499471ms","start":"2026-02-25T01:39:16.621953Z","end":"2026-02-25T01:39:16.895453Z","steps":["trace[133817693] 'process raft request' (duration: 273.223575ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:39:16.895674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.961324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T01:39:16.895748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.857564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-25T01:39:16.895768Z","caller":"traceutil/trace.go:171","msg":"trace[305372059] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:722; }","duration":"149.119759ms","start":"2026-02-25T01:39:16.746628Z","end":"2026-02-25T01:39:16.895748Z","steps":["trace[305372059] 'agreement among raft nodes before linearized reading' (duration: 148.935874ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:39:16.89583Z","caller":"traceutil/trace.go:171","msg":"trace[918114886] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:722; }","duration":"255.963966ms","start":"2026-02-25T01:39:16.639841Z","end":"2026-02-25T01:39:16.895804Z","steps":["trace[918114886] 'agreement among raft nodes before linearized reading' (duration: 255.759341ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:39:18.708613Z","caller":"traceutil/trace.go:171","msg":"trace[1144123931] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"310.174834ms","start":"2026-02-25T01:39:18.398411Z","end":"2026-02-25T01:39:18.708586Z","steps":["trace[1144123931] 'process raft request' (duration: 310.00676ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:39:18.708763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:39:18.398397Z","time spent":"310.284927ms","remote":"127.0.0.1:58228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:39:18.833232Z","caller":"traceutil/trace.go:171","msg":"trace[600608020] linearizableReadLoop","detail":"{readStateIndex:752; appliedIndex:749; }","duration":"379.92361ms","start":"2026-02-25T01:39:18.453283Z","end":"2026-02-25T01:39:18.833206Z","steps":["trace[600608020] 'read index received' (duration: 255.172757ms)","trace[600608020] 'applied index is now lower than readState.Index' (duration: 124.749743ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:39:18.833301Z","caller":"traceutil/trace.go:171","msg":"trace[449472553] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"433.190875ms","start":"2026-02-25T01:39:18.400081Z","end":"2026-02-25T01:39:18.833272Z","steps":["trace[449472553] 'process raft request' (duration: 433.067552ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:39:18.833311Z","caller":"traceutil/trace.go:171","msg":"trace[150042586] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"434.671451ms","start":"2026-02-25T01:39:18.398599Z","end":"2026-02-25T01:39:18.83327Z","steps":["trace[150042586] 'process raft request' (duration: 414.668954ms)","trace[150042586] 'compare' (duration: 19.70628ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:39:18.833447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.134565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T01:39:18.833456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:39:18.400072Z","time spent":"433.291147ms","remote":"127.0.0.1:58228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:39:18.833494Z","caller":"traceutil/trace.go:171","msg":"trace[2089181830] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:726; }","duration":"380.220037ms","start":"2026-02-25T01:39:18.453262Z","end":"2026-02-25T01:39:18.833482Z","steps":["trace[2089181830] 'agreement among raft nodes before linearized reading' (duration: 380.100914ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:39:18.833509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:39:18.398581Z","time spent":"434.828584ms","remote":"127.0.0.1:58228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:39:18.833537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:39:18.453253Z","time spent":"380.275268ms","remote":"127.0.0.1:57968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-25T01:39:41.20979Z","caller":"traceutil/trace.go:171","msg":"trace[1362565504] linearizableReadLoop","detail":"{readStateIndex:824; appliedIndex:823; }","duration":"256.847675ms","start":"2026-02-25T01:39:40.952916Z","end":"2026-02-25T01:39:41.209763Z","steps":["trace[1362565504] 'read index received' (duration: 256.668172ms)","trace[1362565504] 'applied index is now lower than readState.Index' (duration: 178.383µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:39:41.209889Z","caller":"traceutil/trace.go:171","msg":"trace[604212548] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"257.895178ms","start":"2026-02-25T01:39:40.951957Z","end":"2026-02-25T01:39:41.209852Z","steps":["trace[604212548] 'process raft request' (duration: 257.604071ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:39:41.21009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.394335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-02-25T01:39:41.210144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.857672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-25T01:39:41.210158Z","caller":"traceutil/trace.go:171","msg":"trace[1597956805] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:793; }","duration":"136.522928ms","start":"2026-02-25T01:39:41.073617Z","end":"2026-02-25T01:39:41.21014Z","steps":["trace[1597956805] 'agreement among raft nodes before linearized reading' (duration: 136.302893ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:39:41.210219Z","caller":"traceutil/trace.go:171","msg":"trace[900639176] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:793; }","duration":"108.000995ms","start":"2026-02-25T01:39:41.1022Z","end":"2026-02-25T01:39:41.210201Z","steps":["trace[900639176] 'agreement among raft nodes before linearized reading' (duration: 107.77232ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:39:41.210236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.272335ms","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-25T01:39:41.210368Z","caller":"traceutil/trace.go:171","msg":"trace[1392021566] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:793; }","duration":"257.450609ms","start":"2026-02-25T01:39:40.952891Z","end":"2026-02-25T01:39:41.210342Z","steps":["trace[1392021566] 'agreement among raft nodes before linearized reading' (duration: 257.0394ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:39:53.359093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"723.985304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T01:39:53.359183Z","caller":"traceutil/trace.go:171","msg":"trace[412334833] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:876; }","duration":"724.106547ms","start":"2026-02-25T01:39:52.635057Z","end":"2026-02-25T01:39:53.359164Z","steps":["trace[412334833] 'count revisions from in-memory index tree' (duration: 723.926562ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:39:53.359224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:39:52.635047Z","time spent":"724.165469ms","remote":"127.0.0.1:58476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-02-25T01:39:53.359316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.756338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T01:39:53.359388Z","caller":"traceutil/trace.go:171","msg":"trace[1692800402] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:876; }","duration":"612.847939ms","start":"2026-02-25T01:39:52.746515Z","end":"2026-02-25T01:39:53.359363Z","steps":["trace[1692800402] 'range keys from in-memory index tree' (duration: 612.686036ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:39:53.359417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:39:52.746504Z","time spent":"612.908381ms","remote":"127.0.0.1:57968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-25T01:39:53.359582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.200703ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T01:39:53.359651Z","caller":"traceutil/trace.go:171","msg":"trace[634229732] linearizableReadLoop","detail":"{readStateIndex:913; appliedIndex:912; }","duration":"474.39068ms","start":"2026-02-25T01:39:52.885249Z","end":"2026-02-25T01:39:53.359639Z","steps":["trace[634229732] 'read index received' (duration: 314.001503ms)","trace[634229732] 'applied index is now lower than readState.Index' (duration: 160.388097ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:39:53.359728Z","caller":"traceutil/trace.go:171","msg":"trace[558401893] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"543.008111ms","start":"2026-02-25T01:39:52.81671Z","end":"2026-02-25T01:39:53.359718Z","steps":["trace[558401893] 'process raft request' (duration: 382.603283ms)","trace[558401893] 'compare' (duration: 159.900037ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:39:53.359782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:39:52.816694Z","time spent":"543.061033ms","remote":"127.0.0.1:58228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:39:53.359811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.000413ms","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-25T01:39:53.359831Z","caller":"traceutil/trace.go:171","msg":"trace[1669911672] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:877; }","duration":"102.052684ms","start":"2026-02-25T01:39:53.257771Z","end":"2026-02-25T01:39:53.359824Z","steps":["trace[1669911672] 'agreement among raft nodes before linearized reading' (duration: 101.981563ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:39:53.359901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.652286ms","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-25T01:39:53.359917Z","caller":"traceutil/trace.go:171","msg":"trace[1645583763] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:877; }","duration":"474.688137ms","start":"2026-02-25T01:39:52.885225Z","end":"2026-02-25T01:39:53.359913Z","steps":["trace[1645583763] 'agreement among raft nodes before linearized reading' (duration: 474.645236ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:39:53.359929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:39:52.885215Z","time spent":"474.711087ms","remote":"127.0.0.1:58228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-25T01:39:53.819097Z","caller":"traceutil/trace.go:171","msg":"trace[1441749270] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"454.801955ms","start":"2026-02-25T01:39:53.364264Z","end":"2026-02-25T01:39:53.819066Z","steps":["trace[1441749270] 'process raft request' (duration: 451.776708ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:39:53.819673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:39:53.364255Z","time spent":"454.938408ms","remote":"127.0.0.1:58228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:39:53.824631Z","caller":"traceutil/trace.go:171","msg":"trace[1741613453] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"456.83205ms","start":"2026-02-25T01:39:53.367788Z","end":"2026-02-25T01:39:53.82462Z","steps":["trace[1741613453] 'process raft request' (duration: 456.802759ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:39:53.824861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:39:53.367779Z","time spent":"456.892171ms","remote":"127.0.0.1:58228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:39:53.824975Z","caller":"traceutil/trace.go:171","msg":"trace[1755360762] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"458.545879ms","start":"2026-02-25T01:39:53.366393Z","end":"2026-02-25T01:39:53.824938Z","steps":["trace[1755360762] 'process raft request' (duration: 458.14396ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:39:53.824948Z","caller":"traceutil/trace.go:171","msg":"trace[1340220615] transaction","detail":"{read_only:false; response_revision:879; number_of_response:1; }","duration":"458.589199ms","start":"2026-02-25T01:39:53.3663Z","end":"2026-02-25T01:39:53.824889Z","steps":["trace[1340220615] 'process raft request' (duration: 458.15127ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:39:53.825102Z","caller":"traceutil/trace.go:171","msg":"trace[1572426057] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"458.597419ms","start":"2026-02-25T01:39:53.366443Z","end":"2026-02-25T01:39:53.82504Z","steps":["trace[1572426057] 'process raft request' (duration: 458.121988ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:39:53.82517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:39:53.366385Z","time spent":"458.668801ms","remote":"127.0.0.1:58228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:39:53.825174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:39:53.366281Z","time spent":"458.856445ms","remote":"127.0.0.1:58228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:39:53.825274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:39:53.366436Z","time spent":"458.742503ms","remote":"127.0.0.1:58228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:40:12.998876Z","caller":"traceutil/trace.go:171","msg":"trace[921963592] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"231.081214ms","start":"2026-02-25T01:40:12.767761Z","end":"2026-02-25T01:40:12.998842Z","steps":["trace[921963592] 'process raft request' (duration: 185.762079ms)","trace[921963592] 'compare' (duration: 45.12067ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:40:14.102028Z","caller":"traceutil/trace.go:171","msg":"trace[615622896] linearizableReadLoop","detail":"{readStateIndex:988; appliedIndex:987; }","duration":"157.347099ms","start":"2026-02-25T01:40:13.944648Z","end":"2026-02-25T01:40:14.101995Z","steps":["trace[615622896] 'read index received' (duration: 156.995981ms)","trace[615622896] 'applied index is now lower than readState.Index' (duration: 349.408µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:40:14.102466Z","caller":"traceutil/trace.go:171","msg":"trace[39031505] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"214.308712ms","start":"2026-02-25T01:40:13.888139Z","end":"2026-02-25T01:40:14.102448Z","steps":["trace[39031505] 'process raft request' (duration: 213.604546ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:40:14.102834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.156507ms","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-25T01:40:14.102886Z","caller":"traceutil/trace.go:171","msg":"trace[623435696] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:948; }","duration":"158.28682ms","start":"2026-02-25T01:40:13.944585Z","end":"2026-02-25T01:40:14.102872Z","steps":["trace[623435696] 'agreement among raft nodes before linearized reading' (duration: 158.083875ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:40:14.291094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.740316ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T01:40:14.291399Z","caller":"traceutil/trace.go:171","msg":"trace[705041404] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"182.840785ms","start":"2026-02-25T01:40:14.108534Z","end":"2026-02-25T01:40:14.291375Z","steps":["trace[705041404] 'process raft request' (duration: 15.678088ms)","trace[705041404] 'compare' (duration: 166.554693ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:40:14.291705Z","caller":"traceutil/trace.go:171","msg":"trace[89331363] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"181.097046ms","start":"2026-02-25T01:40:14.110589Z","end":"2026-02-25T01:40:14.291686Z","steps":["trace[89331363] 'process raft request' (duration: 180.673336ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:40:14.291836Z","caller":"traceutil/trace.go:171","msg":"trace[2101187625] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"181.131177ms","start":"2026-02-25T01:40:14.110691Z","end":"2026-02-25T01:40:14.291822Z","steps":["trace[2101187625] 'process raft request' (duration: 180.991264ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:40:14.291949Z","caller":"traceutil/trace.go:171","msg":"trace[669084977] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"181.28662ms","start":"2026-02-25T01:40:14.110652Z","end":"2026-02-25T01:40:14.291939Z","steps":["trace[669084977] 'process raft request' (duration: 180.939903ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:40:14.292039Z","caller":"traceutil/trace.go:171","msg":"trace[2123411728] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"179.226934ms","start":"2026-02-25T01:40:14.112781Z","end":"2026-02-25T01:40:14.292008Z","steps":["trace[2123411728] 'process raft request' (duration: 178.926997ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:43:19.878909Z","caller":"traceutil/trace.go:171","msg":"trace[189164922] transaction","detail":"{read_only:false; response_revision:1746; number_of_response:1; }","duration":"102.056973ms","start":"2026-02-25T01:43:19.776825Z","end":"2026-02-25T01:43:19.878882Z","steps":["trace[189164922] 'process raft request' (duration: 49.594485ms)","trace[189164922] 'compare' (duration: 52.003498ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:43:20.729637Z","caller":"traceutil/trace.go:171","msg":"trace[177346822] transaction","detail":"{read_only:false; response_revision:1748; number_of_response:1; }","duration":"148.093009ms","start":"2026-02-25T01:43:20.581281Z","end":"2026-02-25T01:43:20.729374Z","steps":["trace[177346822] 'process raft request' (duration: 147.914025ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:43:21.910111Z","caller":"traceutil/trace.go:171","msg":"trace[185307541] transaction","detail":"{read_only:false; response_revision:1752; number_of_response:1; }","duration":"131.701471ms","start":"2026-02-25T01:43:21.778363Z","end":"2026-02-25T01:43:21.910064Z","steps":["trace[185307541] 'process raft request' (duration: 74.703499ms)","trace[185307541] 'compare' (duration: 56.853529ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:43:21.916173Z","caller":"traceutil/trace.go:171","msg":"trace[1628461782] linearizableReadLoop","detail":"{readStateIndex:1830; appliedIndex:1828; }","duration":"124.869317ms","start":"2026-02-25T01:43:21.79127Z","end":"2026-02-25T01:43:21.91614Z","steps":["trace[1628461782] 'read index received' (duration: 61.757168ms)","trace[1628461782] 'applied index is now lower than readState.Index' (duration: 63.110699ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:43:21.916294Z","caller":"traceutil/trace.go:171","msg":"trace[171840239] transaction","detail":"{read_only:false; response_revision:1753; number_of_response:1; }","duration":"135.899395ms","start":"2026-02-25T01:43:21.780383Z","end":"2026-02-25T01:43:21.916282Z","steps":["trace[171840239] 'process raft request' (duration: 135.64081ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:43:21.916863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.573432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:6 size:363634"} {"level":"info","ts":"2026-02-25T01:43:21.916907Z","caller":"traceutil/trace.go:171","msg":"trace[1400550488] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:6; response_revision:1753; }","duration":"125.659565ms","start":"2026-02-25T01:43:21.791234Z","end":"2026-02-25T01:43:21.916893Z","steps":["trace[1400550488] 'agreement among raft nodes before linearized reading' (duration: 125.191604ms)"],"step_count":1}