{"level":"warn","ts":"2026-07-14T17:42:32.066092Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-14T17:42:32.066258Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.100:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.100:2380","--initial-cluster=instance=https://199.19.213.100:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.100:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.100: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-07-14T17:42:32.066444Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-14T17:42:32.066479Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.100:2380"]} {"level":"info","ts":"2026-07-14T17:42:32.066522Z","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-07-14T17:42:32.067653Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.100:2379"]} {"level":"info","ts":"2026-07-14T17:42:32.067856Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.100:2380"],"listen-peer-urls":["https://199.19.213.100:2380"],"advertise-client-urls":["https://199.19.213.100:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.100:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.100: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-07-14T17:42:32.07496Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.71607ms"} {"level":"info","ts":"2026-07-14T17:42:32.086433Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"79e65b4197a2a1a","cluster-id":"bba89cbb2a6fc22a"} {"level":"info","ts":"2026-07-14T17:42:32.086576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a switched to configuration voters=()"} {"level":"info","ts":"2026-07-14T17:42:32.086615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a became follower at term 0"} {"level":"info","ts":"2026-07-14T17:42:32.086632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 79e65b4197a2a1a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-14T17:42:32.086647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a became follower at term 1"} {"level":"info","ts":"2026-07-14T17:42:32.086707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a switched to configuration voters=(548988028781734426)"} {"level":"warn","ts":"2026-07-14T17:42:32.095767Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-14T17:42:32.100082Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-14T17:42:32.103023Z","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-07-14T17:42:32.107426Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"79e65b4197a2a1a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-14T17:42:32.107825Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"79e65b4197a2a1a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-14T17:42:32.107934Z","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-07-14T17:42:32.108056Z","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-07-14T17:42:32.108083Z","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-07-14T17:42:32.109552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a switched to configuration voters=(548988028781734426)"} {"level":"info","ts":"2026-07-14T17:42:32.109771Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bba89cbb2a6fc22a","local-member-id":"79e65b4197a2a1a","added-peer-id":"79e65b4197a2a1a","added-peer-peer-urls":["https://199.19.213.100:2380"]} {"level":"info","ts":"2026-07-14T17:42:32.112668Z","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-07-14T17:42:32.112808Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.100:2380"} {"level":"info","ts":"2026-07-14T17:42:32.112882Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.100:2380"} {"level":"info","ts":"2026-07-14T17:42:32.113804Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"79e65b4197a2a1a","initial-advertise-peer-urls":["https://199.19.213.100:2380"],"listen-peer-urls":["https://199.19.213.100:2380"],"advertise-client-urls":["https://199.19.213.100:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.100:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-14T17:42:32.113841Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-14T17:42:32.68729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a is starting a new election at term 1"} {"level":"info","ts":"2026-07-14T17:42:32.687367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a became pre-candidate at term 1"} {"level":"info","ts":"2026-07-14T17:42:32.687424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a received MsgPreVoteResp from 79e65b4197a2a1a at term 1"} {"level":"info","ts":"2026-07-14T17:42:32.687446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a became candidate at term 2"} {"level":"info","ts":"2026-07-14T17:42:32.687458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a received MsgVoteResp from 79e65b4197a2a1a at term 2"} {"level":"info","ts":"2026-07-14T17:42:32.687476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a became leader at term 2"} {"level":"info","ts":"2026-07-14T17:42:32.687495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 79e65b4197a2a1a elected leader 79e65b4197a2a1a at term 2"} {"level":"info","ts":"2026-07-14T17:42:33.094086Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T17:42:33.096039Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"79e65b4197a2a1a","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.100:2379]}","request-path":"/0/members/79e65b4197a2a1a/attributes","cluster-id":"bba89cbb2a6fc22a","publish-timeout":"7s"} {"level":"info","ts":"2026-07-14T17:42:33.096142Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-14T17:42:33.096219Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-14T17:42:33.096703Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-14T17:42:33.096736Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-14T17:42:33.097356Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bba89cbb2a6fc22a","local-member-id":"79e65b4197a2a1a","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T17:42:33.097643Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T17:42:33.097703Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T17:42:33.098847Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.100:2379"} {"level":"info","ts":"2026-07-14T17:42:33.101908Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-14T17:43:15.578085Z","caller":"traceutil/trace.go:171","msg":"trace[1829377918] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"489.594116ms","start":"2026-07-14T17:43:15.08847Z","end":"2026-07-14T17:43:15.578064Z","steps":["trace[1829377918] 'process raft request' (duration: 489.475064ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:15.578602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:15.088455Z","time spent":"489.71027ms","remote":"127.0.0.1:46082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10362,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T17:43:15.669289Z","caller":"traceutil/trace.go:171","msg":"trace[2042692853] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"579.160762ms","start":"2026-07-14T17:43:15.0901Z","end":"2026-07-14T17:43:15.669261Z","steps":["trace[2042692853] 'process raft request' (duration: 578.948287ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:43:15.669305Z","caller":"traceutil/trace.go:171","msg":"trace[1606507122] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:615; }","duration":"537.906832ms","start":"2026-07-14T17:43:15.131376Z","end":"2026-07-14T17:43:15.669283Z","steps":["trace[1606507122] 'read index received' (duration: 446.574848ms)","trace[1606507122] 'applied index is now lower than readState.Index' (duration: 91.331004ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:43:15.669339Z","caller":"traceutil/trace.go:171","msg":"trace[21899993] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"442.551529ms","start":"2026-07-14T17:43:15.226763Z","end":"2026-07-14T17:43:15.669315Z","steps":["trace[21899993] 'process raft request' (duration: 442.407266ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:43:15.669412Z","caller":"traceutil/trace.go:171","msg":"trace[803003185] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"351.181345ms","start":"2026-07-14T17:43:15.318218Z","end":"2026-07-14T17:43:15.669399Z","steps":["trace[803003185] 'process raft request' (duration: 350.9876ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:15.669435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:15.090079Z","time spent":"579.282355ms","remote":"127.0.0.1:46310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T17:43:15.669462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:15.226741Z","time spent":"442.673742ms","remote":"127.0.0.1:46082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-14T17:43:15.669511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:15.318197Z","time spent":"351.243136ms","remote":"127.0.0.1:46310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T17:43:15.669594Z","caller":"traceutil/trace.go:171","msg":"trace[340983945] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"240.503034ms","start":"2026-07-14T17:43:15.429011Z","end":"2026-07-14T17:43:15.669514Z","steps":["trace[340983945] 'process raft request' (duration: 240.233048ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:15.66972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.316221ms","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-07-14T17:43:15.669825Z","caller":"traceutil/trace.go:171","msg":"trace[1620906247] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:600; }","duration":"538.457385ms","start":"2026-07-14T17:43:15.131347Z","end":"2026-07-14T17:43:15.669804Z","steps":["trace[1620906247] 'agreement among raft nodes before linearized reading' (duration: 538.167578ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:15.669869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:15.131333Z","time spent":"538.522276ms","remote":"127.0.0.1:46310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-14T17:43:15.69399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.961132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-fpz2t\" ","response":"range_response_count:1 size:4888"} {"level":"info","ts":"2026-07-14T17:43:15.694077Z","caller":"traceutil/trace.go:171","msg":"trace[1237365240] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-fpz2t; range_end:; response_count:1; response_revision:601; }","duration":"133.072684ms","start":"2026-07-14T17:43:15.56098Z","end":"2026-07-14T17:43:15.694052Z","steps":["trace[1237365240] 'agreement among raft nodes before linearized reading' (duration: 132.904421ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:16.320756Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3033912541054475015,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-14T17:43:16.321592Z","caller":"traceutil/trace.go:171","msg":"trace[27887359] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"501.978639ms","start":"2026-07-14T17:43:15.819583Z","end":"2026-07-14T17:43:16.321562Z","steps":["trace[27887359] 'process raft request' (duration: 501.804625ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:16.321934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:15.819572Z","time spent":"502.193434ms","remote":"127.0.0.1:46082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4068,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T17:43:16.452217Z","caller":"traceutil/trace.go:171","msg":"trace[1526028574] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:631; }","duration":"631.814334ms","start":"2026-07-14T17:43:15.820383Z","end":"2026-07-14T17:43:16.452198Z","steps":["trace[1526028574] 'read index received' (duration: 501.259053ms)","trace[1526028574] 'applied index is now lower than readState.Index' (duration: 130.554441ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:43:16.452314Z","caller":"traceutil/trace.go:171","msg":"trace[1082183244] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"423.150773ms","start":"2026-07-14T17:43:16.029156Z","end":"2026-07-14T17:43:16.452307Z","steps":["trace[1082183244] 'process raft request' (duration: 422.802686ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:16.452388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:16.029124Z","time spent":"423.210115ms","remote":"127.0.0.1:46082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-14T17:43:16.452482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.0737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T17:43:16.452564Z","caller":"traceutil/trace.go:171","msg":"trace[1835477038] range","detail":"{range_begin:/registry/services/specs/envoy-gateway-system/envoy-gateway; range_end:; response_count:0; response_revision:613; }","duration":"632.169342ms","start":"2026-07-14T17:43:15.820378Z","end":"2026-07-14T17:43:16.452547Z","steps":["trace[1835477038] 'agreement among raft nodes before linearized reading' (duration: 632.011188ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:16.452609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:15.820338Z","time spent":"632.261934ms","remote":"127.0.0.1:46234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":0,"response size":28,"request content":"key:\"/registry/services/specs/envoy-gateway-system/envoy-gateway\" "} {"level":"warn","ts":"2026-07-14T17:43:16.452678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.746248ms","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-07-14T17:43:16.45281Z","caller":"traceutil/trace.go:171","msg":"trace[1356637801] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"199.064427ms","start":"2026-07-14T17:43:16.253732Z","end":"2026-07-14T17:43:16.452797Z","steps":["trace[1356637801] 'process raft request' (duration: 198.381062ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:43:16.452813Z","caller":"traceutil/trace.go:171","msg":"trace[607388047] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:613; }","duration":"629.922482ms","start":"2026-07-14T17:43:15.822851Z","end":"2026-07-14T17:43:16.452774Z","steps":["trace[607388047] 'agreement among raft nodes before linearized reading' (duration: 629.689247ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:16.452946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:15.822844Z","time spent":"630.088215ms","remote":"127.0.0.1:46082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-07-14T17:43:16.452969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.70385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-14T17:43:16.453083Z","caller":"traceutil/trace.go:171","msg":"trace[1578437022] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:613; }","duration":"390.889644ms","start":"2026-07-14T17:43:16.062173Z","end":"2026-07-14T17:43:16.453062Z","steps":["trace[1578437022] 'agreement among raft nodes before linearized reading' (duration: 390.551397ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:16.453142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:16.062147Z","time spent":"390.982406ms","remote":"127.0.0.1:46310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-14T17:43:24.122822Z","caller":"traceutil/trace.go:171","msg":"trace[663687618] linearizableReadLoop","detail":"{readStateIndex:690; appliedIndex:689; }","duration":"313.553862ms","start":"2026-07-14T17:43:23.809245Z","end":"2026-07-14T17:43:24.122798Z","steps":["trace[663687618] 'read index received' (duration: 313.340878ms)","trace[663687618] 'applied index is now lower than readState.Index' (duration: 212.024µs)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:43:24.122952Z","caller":"traceutil/trace.go:171","msg":"trace[581848436] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"527.412601ms","start":"2026-07-14T17:43:23.595513Z","end":"2026-07-14T17:43:24.122926Z","steps":["trace[581848436] 'process raft request' (duration: 527.152456ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:24.123084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.830488ms","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-07-14T17:43:24.123127Z","caller":"traceutil/trace.go:171","msg":"trace[1180802264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:668; }","duration":"313.92102ms","start":"2026-07-14T17:43:23.809195Z","end":"2026-07-14T17:43:24.123116Z","steps":["trace[1180802264] 'agreement among raft nodes before linearized reading' (duration: 313.772317ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:24.123163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:23.809157Z","time spent":"313.997702ms","remote":"127.0.0.1:46310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-14T17:43:24.123089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:23.595478Z","time spent":"527.536944ms","remote":"127.0.0.1:46222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T17:43:24.123287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.873396ms","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-07-14T17:43:24.123356Z","caller":"traceutil/trace.go:171","msg":"trace[602111787] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:668; }","duration":"292.978048ms","start":"2026-07-14T17:43:23.83036Z","end":"2026-07-14T17:43:24.123338Z","steps":["trace[602111787] 'agreement among raft nodes before linearized reading' (duration: 292.793564ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:43:25.114186Z","caller":"traceutil/trace.go:171","msg":"trace[964363597] linearizableReadLoop","detail":"{readStateIndex:694; appliedIndex:693; }","duration":"251.502749ms","start":"2026-07-14T17:43:24.86266Z","end":"2026-07-14T17:43:25.114163Z","steps":["trace[964363597] 'read index received' (duration: 251.406217ms)","trace[964363597] 'applied index is now lower than readState.Index' (duration: 95.492µs)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:43:25.114388Z","caller":"traceutil/trace.go:171","msg":"trace[1595463364] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"304.471558ms","start":"2026-07-14T17:43:24.809902Z","end":"2026-07-14T17:43:25.114373Z","steps":["trace[1595463364] 'process raft request' (duration: 304.12943ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:25.114538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.864377ms","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-07-14T17:43:25.114598Z","caller":"traceutil/trace.go:171","msg":"trace[763783870] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:672; }","duration":"251.966449ms","start":"2026-07-14T17:43:24.862619Z","end":"2026-07-14T17:43:25.114585Z","steps":["trace[763783870] 'agreement among raft nodes before linearized reading' (duration: 251.766395ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:25.114827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:24.809883Z","time spent":"304.644861ms","remote":"127.0.0.1:46310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T17:43:26.226134Z","caller":"traceutil/trace.go:171","msg":"trace[1239593871] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"437.25948ms","start":"2026-07-14T17:43:25.788844Z","end":"2026-07-14T17:43:26.226103Z","steps":["trace[1239593871] 'process raft request' (duration: 437.065686ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:26.226318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:25.788816Z","time spent":"437.403803ms","remote":"127.0.0.1:46310","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-07-14T17:43:26.914876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.440939ms","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-07-14T17:43:26.915004Z","caller":"traceutil/trace.go:171","msg":"trace[50528000] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:674; }","duration":"480.591132ms","start":"2026-07-14T17:43:26.434386Z","end":"2026-07-14T17:43:26.914977Z","steps":["trace[50528000] 'range keys from in-memory index tree' (duration: 480.422479ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:43:26.915087Z","caller":"traceutil/trace.go:171","msg":"trace[800321002] linearizableReadLoop","detail":"{readStateIndex:698; appliedIndex:696; }","duration":"372.666806ms","start":"2026-07-14T17:43:26.54239Z","end":"2026-07-14T17:43:26.915057Z","steps":["trace[800321002] 'read index received' (duration: 289.653062ms)","trace[800321002] 'applied index is now lower than readState.Index' (duration: 83.012254ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:43:26.915425Z","caller":"traceutil/trace.go:171","msg":"trace[1811457097] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"684.417419ms","start":"2026-07-14T17:43:26.230989Z","end":"2026-07-14T17:43:26.915407Z","steps":["trace[1811457097] 'process raft request' (duration: 683.99989ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:43:26.915425Z","caller":"traceutil/trace.go:171","msg":"trace[1922560296] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"684.4182ms","start":"2026-07-14T17:43:26.230964Z","end":"2026-07-14T17:43:26.915382Z","steps":["trace[1922560296] 'process raft request' (duration: 601.075089ms)","trace[1922560296] 'compare' (duration: 82.496283ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T17:43:26.915534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:26.230964Z","time spent":"684.505272ms","remote":"127.0.0.1:46310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T17:43:26.915593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:26.230946Z","time spent":"684.566563ms","remote":"127.0.0.1:46310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T17:43:26.91562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.928337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.100\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-14T17:43:26.915681Z","caller":"traceutil/trace.go:171","msg":"trace[790693715] range","detail":"{range_begin:/registry/masterleases/199.19.213.100; range_end:; response_count:1; response_revision:676; }","duration":"312.04091ms","start":"2026-07-14T17:43:26.603626Z","end":"2026-07-14T17:43:26.915667Z","steps":["trace[790693715] 'agreement among raft nodes before linearized reading' (duration: 311.832775ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:26.915664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.258938ms","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":"warn","ts":"2026-07-14T17:43:26.915719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:26.603604Z","time spent":"312.105201ms","remote":"127.0.0.1:46058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.100\" "} {"level":"info","ts":"2026-07-14T17:43:26.915746Z","caller":"traceutil/trace.go:171","msg":"trace[1653861114] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:676; }","duration":"373.404901ms","start":"2026-07-14T17:43:26.542322Z","end":"2026-07-14T17:43:26.915727Z","steps":["trace[1653861114] 'agreement among raft nodes before linearized reading' (duration: 373.120835ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:26.91579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:26.542292Z","time spent":"373.488003ms","remote":"127.0.0.1:46310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-14T17:43:27.06142Z","caller":"traceutil/trace.go:171","msg":"trace[1761309989] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"141.442408ms","start":"2026-07-14T17:43:26.919952Z","end":"2026-07-14T17:43:27.061395Z","steps":["trace[1761309989] 'process raft request' (duration: 137.30161ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:39.636661Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3033912541054475346,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T17:43:40.137792Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3033912541054475346,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T17:43:40.348923Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.351871402s","expected-duration":"1s"} {"level":"info","ts":"2026-07-14T17:43:40.349284Z","caller":"traceutil/trace.go:171","msg":"trace[599504360] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"1.352357502s","start":"2026-07-14T17:43:38.996907Z","end":"2026-07-14T17:43:40.349264Z","steps":["trace[599504360] 'process raft request' (duration: 1.352218589s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:40.349436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:38.996882Z","time spent":"1.352483954s","remote":"127.0.0.1:46310","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-07-14T17:43:40.365224Z","caller":"traceutil/trace.go:171","msg":"trace[522302944] linearizableReadLoop","detail":"{readStateIndex:786; appliedIndex:783; }","duration":"1.229606696s","start":"2026-07-14T17:43:39.135598Z","end":"2026-07-14T17:43:40.365205Z","steps":["trace[522302944] 'read index received' (duration: 1.213652398s)","trace[522302944] 'applied index is now lower than readState.Index' (duration: 15.953438ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:43:40.365566Z","caller":"traceutil/trace.go:171","msg":"trace[1465886943] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"1.367900261s","start":"2026-07-14T17:43:38.997657Z","end":"2026-07-14T17:43:40.365557Z","steps":["trace[1465886943] 'process raft request' (duration: 1.367321399s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:40.365671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:38.997641Z","time spent":"1.367951783s","remote":"127.0.0.1:46310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T17:43:40.365841Z","caller":"traceutil/trace.go:171","msg":"trace[1733042360] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"445.298874ms","start":"2026-07-14T17:43:39.920534Z","end":"2026-07-14T17:43:40.365833Z","steps":["trace[1733042360] 'process raft request' (duration: 444.562939ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:40.36588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:39.920519Z","time spent":"445.340045ms","remote":"127.0.0.1:46310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T17:43:40.366068Z","caller":"traceutil/trace.go:171","msg":"trace[1188606416] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"327.823871ms","start":"2026-07-14T17:43:40.038237Z","end":"2026-07-14T17:43:40.366061Z","steps":["trace[1188606416] 'process raft request' (duration: 326.930232ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:40.366135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:40.038221Z","time spent":"327.870011ms","remote":"127.0.0.1:46220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4905,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T17:43:40.366333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.230731799s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-14T17:43:40.366362Z","caller":"traceutil/trace.go:171","msg":"trace[2100188499] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:760; }","duration":"1.230789861s","start":"2026-07-14T17:43:39.135564Z","end":"2026-07-14T17:43:40.366354Z","steps":["trace[2100188499] 'agreement among raft nodes before linearized reading' (duration: 1.230698029s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:40.366408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:39.135547Z","time spent":"1.230853562s","remote":"127.0.0.1:46310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-14T17:43:40.366574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.159601901s","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-07-14T17:43:40.366612Z","caller":"traceutil/trace.go:171","msg":"trace[1190078671] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:760; }","duration":"1.159668942s","start":"2026-07-14T17:43:39.206934Z","end":"2026-07-14T17:43:40.366603Z","steps":["trace[1190078671] 'agreement among raft nodes before linearized reading' (duration: 1.15959261s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:40.366634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:39.206918Z","time spent":"1.159709473s","remote":"127.0.0.1:46310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-14T17:43:40.366715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.496842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-14T17:43:40.366733Z","caller":"traceutil/trace.go:171","msg":"trace[2103664784] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:760; }","duration":"607.556234ms","start":"2026-07-14T17:43:39.759172Z","end":"2026-07-14T17:43:40.366728Z","steps":["trace[2103664784] 'agreement among raft nodes before linearized reading' (duration: 607.523413ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:40.36675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:39.759141Z","time spent":"607.604514ms","remote":"127.0.0.1:46454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"warn","ts":"2026-07-14T17:43:40.366958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.155961926s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-14T17:43:40.366987Z","caller":"traceutil/trace.go:171","msg":"trace[1127134753] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:760; }","duration":"1.156024277s","start":"2026-07-14T17:43:39.210954Z","end":"2026-07-14T17:43:40.366978Z","steps":["trace[1127134753] 'agreement among raft nodes before linearized reading' (duration: 1.155886384s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:40.367008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:39.210937Z","time spent":"1.156065968s","remote":"127.0.0.1:46310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-14T17:43:40.367105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.090907423s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-14T17:43:40.367129Z","caller":"traceutil/trace.go:171","msg":"trace[1048763900] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:760; }","duration":"1.090969305s","start":"2026-07-14T17:43:39.276152Z","end":"2026-07-14T17:43:40.367122Z","steps":["trace[1048763900] 'agreement among raft nodes before linearized reading' (duration: 1.090904133s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:40.367151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:39.276131Z","time spent":"1.091013055s","remote":"127.0.0.1:46418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":52,"response size":30,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"warn","ts":"2026-07-14T17:43:42.728397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.260396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T17:43:42.728465Z","caller":"traceutil/trace.go:171","msg":"trace[1004751502] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:780; }","duration":"124.400778ms","start":"2026-07-14T17:43:42.60405Z","end":"2026-07-14T17:43:42.728451Z","steps":["trace[1004751502] 'range keys from in-memory index tree' (duration: 124.089462ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:46.957135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.241628ms","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-07-14T17:43:46.957222Z","caller":"traceutil/trace.go:171","msg":"trace[560082214] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:794; }","duration":"542.366891ms","start":"2026-07-14T17:43:46.414833Z","end":"2026-07-14T17:43:46.9572Z","steps":["trace[560082214] 'range keys from in-memory index tree' (duration: 542.076455ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:46.957269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.922388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.100\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-07-14T17:43:46.957275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:46.414814Z","time spent":"542.446332ms","remote":"127.0.0.1:46310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-14T17:43:46.957382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.069951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T17:43:46.957414Z","caller":"traceutil/trace.go:171","msg":"trace[332184013] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:794; }","duration":"352.149892ms","start":"2026-07-14T17:43:46.605254Z","end":"2026-07-14T17:43:46.957404Z","steps":["trace[332184013] 'range keys from in-memory index tree' (duration: 352.006629ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:46.95745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:46.605234Z","time spent":"352.207574ms","remote":"127.0.0.1:46026","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-07-14T17:43:46.95746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.098625ms","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-07-14T17:43:46.957515Z","caller":"traceutil/trace.go:171","msg":"trace[6434398] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:794; }","duration":"542.364141ms","start":"2026-07-14T17:43:46.415135Z","end":"2026-07-14T17:43:46.957499Z","steps":["trace[6434398] 'range keys from in-memory index tree' (duration: 542.011734ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:46.957553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:46.415129Z","time spent":"542.412752ms","remote":"127.0.0.1:46310","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":"warn","ts":"2026-07-14T17:43:46.957681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.542019ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-14T17:43:46.957725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.740499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T17:43:46.95776Z","caller":"traceutil/trace.go:171","msg":"trace[1973345405] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:794; }","duration":"523.62291ms","start":"2026-07-14T17:43:46.434123Z","end":"2026-07-14T17:43:46.957746Z","steps":["trace[1973345405] 'range keys from in-memory index tree' (duration: 523.532808ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:43:46.95778Z","caller":"traceutil/trace.go:171","msg":"trace[354757995] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:794; }","duration":"474.835351ms","start":"2026-07-14T17:43:46.482928Z","end":"2026-07-14T17:43:46.957763Z","steps":["trace[354757995] 'count revisions from in-memory index tree' (duration: 474.666658ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:46.957827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:46.482909Z","time spent":"474.904532ms","remote":"127.0.0.1:46268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-07-14T17:43:46.958179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.298771ms","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-07-14T17:43:46.95734Z","caller":"traceutil/trace.go:171","msg":"trace[1428904828] range","detail":"{range_begin:/registry/masterleases/199.19.213.100; range_end:; response_count:1; response_revision:794; }","duration":"353.01341ms","start":"2026-07-14T17:43:46.604305Z","end":"2026-07-14T17:43:46.957319Z","steps":["trace[1428904828] 'range keys from in-memory index tree' (duration: 352.750355ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:46.958328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.098298ms","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-07-14T17:43:46.958379Z","caller":"traceutil/trace.go:171","msg":"trace[681836750] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:794; }","duration":"586.18344ms","start":"2026-07-14T17:43:46.372183Z","end":"2026-07-14T17:43:46.958367Z","steps":["trace[681836750] 'range keys from in-memory index tree' (duration: 585.896554ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:46.958387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:46.604289Z","time spent":"354.020681ms","remote":"127.0.0.1:46058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.100\" "} {"level":"warn","ts":"2026-07-14T17:43:46.958564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.823584ms","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-07-14T17:43:46.958621Z","caller":"traceutil/trace.go:171","msg":"trace[841003995] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:794; }","duration":"557.914816ms","start":"2026-07-14T17:43:46.400688Z","end":"2026-07-14T17:43:46.958603Z","steps":["trace[841003995] 'range keys from in-memory index tree' (duration: 557.588789ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:46.958423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:46.372131Z","time spent":"586.281052ms","remote":"127.0.0.1:46310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-14T17:43:46.958236Z","caller":"traceutil/trace.go:171","msg":"trace[291584457] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:794; }","duration":"548.382153ms","start":"2026-07-14T17:43:46.40984Z","end":"2026-07-14T17:43:46.958222Z","steps":["trace[291584457] 'range keys from in-memory index tree' (duration: 548.185698ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:46.958738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:46.409824Z","time spent":"548.897813ms","remote":"127.0.0.1:46310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-14T17:43:46.958946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:46.400666Z","time spent":"557.988848ms","remote":"127.0.0.1:46310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-14T17:43:46.959334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.393557ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T17:43:46.959425Z","caller":"traceutil/trace.go:171","msg":"trace[280074233] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"294.094225ms","start":"2026-07-14T17:43:46.665311Z","end":"2026-07-14T17:43:46.959405Z","steps":["trace[280074233] 'process raft request' (duration: 155.377211ms)","trace[280074233] 'compare' (duration: 137.06757ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:43:47.083182Z","caller":"traceutil/trace.go:171","msg":"trace[1097459178] linearizableReadLoop","detail":"{readStateIndex:824; appliedIndex:823; }","duration":"124.256496ms","start":"2026-07-14T17:43:46.958905Z","end":"2026-07-14T17:43:47.083162Z","steps":["trace[1097459178] 'read index received' (duration: 121.406628ms)","trace[1097459178] 'applied index is now lower than readState.Index' (duration: 2.849078ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:43:47.083404Z","caller":"traceutil/trace.go:171","msg":"trace[285040204] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"370.042251ms","start":"2026-07-14T17:43:46.713326Z","end":"2026-07-14T17:43:47.083368Z","steps":["trace[285040204] 'process raft request' (duration: 366.977559ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:47.083441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.521852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T17:43:47.083477Z","caller":"traceutil/trace.go:171","msg":"trace[385428853] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:796; }","duration":"124.595423ms","start":"2026-07-14T17:43:46.958869Z","end":"2026-07-14T17:43:47.083465Z","steps":["trace[385428853] 'agreement among raft nodes before linearized reading' (duration: 124.493121ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:47.08353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:46.713302Z","time spent":"370.163564ms","remote":"127.0.0.1:46278","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T17:43:47.086909Z","caller":"traceutil/trace.go:171","msg":"trace[1316472661] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"123.303826ms","start":"2026-07-14T17:43:46.963592Z","end":"2026-07-14T17:43:47.086896Z","steps":["trace[1316472661] 'process raft request' (duration: 123.213104ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:43:47.086928Z","caller":"traceutil/trace.go:171","msg":"trace[91273947] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"123.47921ms","start":"2026-07-14T17:43:46.963434Z","end":"2026-07-14T17:43:47.086914Z","steps":["trace[91273947] 'process raft request' (duration: 123.289296ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:43:47.087046Z","caller":"traceutil/trace.go:171","msg":"trace[1378158199] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"123.383348ms","start":"2026-07-14T17:43:46.963656Z","end":"2026-07-14T17:43:47.087039Z","steps":["trace[1378158199] 'process raft request' (duration: 123.172624ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:43:47.087279Z","caller":"traceutil/trace.go:171","msg":"trace[1675575378] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"123.49726ms","start":"2026-07-14T17:43:46.963741Z","end":"2026-07-14T17:43:47.087239Z","steps":["trace[1675575378] 'process raft request' (duration: 123.273926ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:43:47.087357Z","caller":"traceutil/trace.go:171","msg":"trace[375618032] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"123.447729ms","start":"2026-07-14T17:43:46.963891Z","end":"2026-07-14T17:43:47.087339Z","steps":["trace[375618032] 'process raft request' (duration: 123.298776ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:52.441522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.478324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050260"} {"level":"info","ts":"2026-07-14T17:43:52.44159Z","caller":"traceutil/trace.go:171","msg":"trace[950870076] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:850; }","duration":"746.590536ms","start":"2026-07-14T17:43:51.694984Z","end":"2026-07-14T17:43:52.441574Z","steps":["trace[950870076] 'range keys from in-memory index tree' (duration: 745.655008ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:52.441623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:51.694967Z","time spent":"746.645827ms","remote":"127.0.0.1:46114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":5,"response size":1050283,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"info","ts":"2026-07-14T17:43:54.869028Z","caller":"traceutil/trace.go:171","msg":"trace[1910672021] transaction","detail":"{read_only:false; response_revision:866; number_of_response:1; }","duration":"121.747222ms","start":"2026-07-14T17:43:54.747253Z","end":"2026-07-14T17:43:54.869Z","steps":["trace[1910672021] 'process raft request' (duration: 121.540378ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:43:55.256546Z","caller":"traceutil/trace.go:171","msg":"trace[680943532] linearizableReadLoop","detail":"{readStateIndex:898; appliedIndex:897; }","duration":"111.249318ms","start":"2026-07-14T17:43:55.145275Z","end":"2026-07-14T17:43:55.256524Z","steps":["trace[680943532] 'read index received' (duration: 33.218669ms)","trace[680943532] 'applied index is now lower than readState.Index' (duration: 78.030019ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T17:43:55.256807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.525283ms","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-07-14T17:43:55.256869Z","caller":"traceutil/trace.go:171","msg":"trace[2000279700] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:868; }","duration":"111.626555ms","start":"2026-07-14T17:43:55.145229Z","end":"2026-07-14T17:43:55.256855Z","steps":["trace[2000279700] 'agreement among raft nodes before linearized reading' (duration: 111.469192ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:43:55.256843Z","caller":"traceutil/trace.go:171","msg":"trace[1778304985] transaction","detail":"{read_only:false; response_revision:868; number_of_response:1; }","duration":"118.758207ms","start":"2026-07-14T17:43:55.138046Z","end":"2026-07-14T17:43:55.256804Z","steps":["trace[1778304985] 'process raft request' (duration: 112.977562ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:44:00.336929Z","caller":"traceutil/trace.go:171","msg":"trace[94018562] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"130.025321ms","start":"2026-07-14T17:44:00.20688Z","end":"2026-07-14T17:44:00.336906Z","steps":["trace[94018562] 'process raft request' (duration: 113.862794ms)","trace[94018562] 'compare' (duration: 16.012214ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:44:02.294539Z","caller":"traceutil/trace.go:171","msg":"trace[1298014107] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"102.377009ms","start":"2026-07-14T17:44:02.192141Z","end":"2026-07-14T17:44:02.294518Z","steps":["trace[1298014107] 'process raft request' (duration: 102.230126ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:44:33.263983Z","caller":"traceutil/trace.go:171","msg":"trace[500925574] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"173.479395ms","start":"2026-07-14T17:44:33.090481Z","end":"2026-07-14T17:44:33.263961Z","steps":["trace[500925574] 'process raft request' (duration: 173.352422ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:45:42.244326Z","caller":"traceutil/trace.go:171","msg":"trace[1798424402] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"135.688641ms","start":"2026-07-14T17:45:42.108592Z","end":"2026-07-14T17:45:42.244281Z","steps":["trace[1798424402] 'process raft request' (duration: 84.985527ms)","trace[1798424402] 'compare' (duration: 50.528771ms)"],"step_count":2}