{"level":"warn","ts":"2026-05-11T10:48:43.547493Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-11T10:48:43.549107Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.179: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.179:2380","--initial-cluster=instance=https://199.19.213.179:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.179:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.179: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-05-11T10:48:43.549244Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-11T10:48:43.549287Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.179:2380"]} {"level":"info","ts":"2026-05-11T10:48:43.549328Z","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-05-11T10:48:43.550331Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.179:2379"]} {"level":"info","ts":"2026-05-11T10:48:43.550494Z","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.179:2380"],"listen-peer-urls":["https://199.19.213.179:2380"],"advertise-client-urls":["https://199.19.213.179:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.179:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.179: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-05-11T10:48:43.555891Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.097544ms"} {"level":"info","ts":"2026-05-11T10:48:43.563491Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"69895f7c3b831156","cluster-id":"caac76e5ff14ceff"} {"level":"info","ts":"2026-05-11T10:48:43.563668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 switched to configuration voters=()"} {"level":"info","ts":"2026-05-11T10:48:43.563702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 became follower at term 0"} {"level":"info","ts":"2026-05-11T10:48:43.563727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 69895f7c3b831156 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-11T10:48:43.56374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 became follower at term 1"} {"level":"info","ts":"2026-05-11T10:48:43.563793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 switched to configuration voters=(7604714432970821974)"} {"level":"warn","ts":"2026-05-11T10:48:43.570755Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-11T10:48:43.572045Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-11T10:48:43.573057Z","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-05-11T10:48:43.575069Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"69895f7c3b831156","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-11T10:48:43.575241Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"69895f7c3b831156","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-11T10:48:43.57547Z","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-05-11T10:48:43.575595Z","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-05-11T10:48:43.575713Z","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-05-11T10:48:43.576143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 switched to configuration voters=(7604714432970821974)"} {"level":"info","ts":"2026-05-11T10:48:43.57626Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"caac76e5ff14ceff","local-member-id":"69895f7c3b831156","added-peer-id":"69895f7c3b831156","added-peer-peer-urls":["https://199.19.213.179:2380"]} {"level":"info","ts":"2026-05-11T10:48:43.580745Z","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-05-11T10:48:43.58093Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"69895f7c3b831156","initial-advertise-peer-urls":["https://199.19.213.179:2380"],"listen-peer-urls":["https://199.19.213.179:2380"],"advertise-client-urls":["https://199.19.213.179:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.179:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-11T10:48:43.580962Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-11T10:48:43.581064Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.179:2380"} {"level":"info","ts":"2026-05-11T10:48:43.58108Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.179:2380"} {"level":"info","ts":"2026-05-11T10:48:43.664998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 is starting a new election at term 1"} {"level":"info","ts":"2026-05-11T10:48:43.66504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-11T10:48:43.66506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 received MsgPreVoteResp from 69895f7c3b831156 at term 1"} {"level":"info","ts":"2026-05-11T10:48:43.665076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 became candidate at term 2"} {"level":"info","ts":"2026-05-11T10:48:43.665087Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 received MsgVoteResp from 69895f7c3b831156 at term 2"} {"level":"info","ts":"2026-05-11T10:48:43.665101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 became leader at term 2"} {"level":"info","ts":"2026-05-11T10:48:43.665114Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 69895f7c3b831156 elected leader 69895f7c3b831156 at term 2"} {"level":"info","ts":"2026-05-11T10:48:43.666268Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:48:43.667661Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"69895f7c3b831156","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.179:2379]}","request-path":"/0/members/69895f7c3b831156/attributes","cluster-id":"caac76e5ff14ceff","publish-timeout":"7s"} {"level":"info","ts":"2026-05-11T10:48:43.667846Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T10:48:43.667908Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T10:48:43.668629Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"caac76e5ff14ceff","local-member-id":"69895f7c3b831156","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:48:43.668745Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:48:43.668799Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:48:43.669065Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-11T10:48:43.669088Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-11T10:48:43.671054Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.179:2379"} {"level":"info","ts":"2026-05-11T10:48:43.674115Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-11T10:48:47.137996Z","caller":"traceutil/trace.go:171","msg":"trace[1025840884] transaction","detail":"{read_only:false; response_revision:193; number_of_response:1; }","duration":"171.600911ms","start":"2026-05-11T10:48:46.96637Z","end":"2026-05-11T10:48:47.137971Z","steps":["trace[1025840884] 'process raft request' (duration: 171.468218ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:48:47.551676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.589329ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:48:47.551762Z","caller":"traceutil/trace.go:171","msg":"trace[526051797] transaction","detail":"{read_only:false; response_revision:194; number_of_response:1; }","duration":"525.775789ms","start":"2026-05-11T10:48:47.025974Z","end":"2026-05-11T10:48:47.55175Z","steps":["trace[526051797] 'process raft request' (duration: 274.78487ms)","trace[526051797] 'compare' (duration: 250.476667ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:48:47.551824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:48:47.025941Z","time spent":"525.868241ms","remote":"127.0.0.1:59274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1069,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:48:47.857061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.800297ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:48:47.85715Z","caller":"traceutil/trace.go:171","msg":"trace[1442906317] transaction","detail":"{read_only:false; response_revision:195; number_of_response:1; }","duration":"717.554983ms","start":"2026-05-11T10:48:47.139578Z","end":"2026-05-11T10:48:47.857133Z","steps":["trace[1442906317] 'process raft request' (duration: 616.615123ms)","trace[1442906317] 'compare' (duration: 100.650704ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:48:47.857349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:48:47.139554Z","time spent":"717.622984ms","remote":"127.0.0.1:59374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":689,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:48:47.862096Z","caller":"traceutil/trace.go:171","msg":"trace[1640305619] transaction","detail":"{read_only:false; response_revision:197; number_of_response:1; }","duration":"307.272168ms","start":"2026-05-11T10:48:47.554806Z","end":"2026-05-11T10:48:47.862078Z","steps":["trace[1640305619] 'process raft request' (duration: 307.104254ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:48:47.862098Z","caller":"traceutil/trace.go:171","msg":"trace[1953285326] transaction","detail":"{read_only:false; response_revision:196; number_of_response:1; }","duration":"310.473519ms","start":"2026-05-11T10:48:47.551593Z","end":"2026-05-11T10:48:47.862067Z","steps":["trace[1953285326] 'process raft request' (duration: 310.224373ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:48:47.862202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:48:47.554793Z","time spent":"307.35476ms","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":342,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:48:47.862229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:48:47.551578Z","time spent":"310.598682ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:49:13.435778Z","caller":"traceutil/trace.go:171","msg":"trace[822165494] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"203.464294ms","start":"2026-05-11T10:49:13.232284Z","end":"2026-05-11T10:49:13.435748Z","steps":["trace[822165494] 'process raft request' (duration: 171.727204ms)","trace[822165494] 'compare' (duration: 31.585017ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:49:13.436023Z","caller":"traceutil/trace.go:171","msg":"trace[1806470710] transaction","detail":"{read_only:false; number_of_response:0; response_revision:488; }","duration":"196.820266ms","start":"2026-05-11T10:49:13.239183Z","end":"2026-05-11T10:49:13.436004Z","steps":["trace[1806470710] 'process raft request' (duration: 196.531969ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:49:13.436413Z","caller":"traceutil/trace.go:171","msg":"trace[1916084062] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"195.176549ms","start":"2026-05-11T10:49:13.241221Z","end":"2026-05-11T10:49:13.436397Z","steps":["trace[1916084062] 'process raft request' (duration: 194.724188ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:49:13.436533Z","caller":"traceutil/trace.go:171","msg":"trace[1580468978] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"193.525052ms","start":"2026-05-11T10:49:13.242996Z","end":"2026-05-11T10:49:13.436521Z","steps":["trace[1580468978] 'process raft request' (duration: 193.050671ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:49:13.436743Z","caller":"traceutil/trace.go:171","msg":"trace[409017954] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"188.519711ms","start":"2026-05-11T10:49:13.248208Z","end":"2026-05-11T10:49:13.436728Z","steps":["trace[409017954] 'process raft request' (duration: 188.140742ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:49:13.437391Z","caller":"traceutil/trace.go:171","msg":"trace[1253908631] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"187.527828ms","start":"2026-05-11T10:49:13.249811Z","end":"2026-05-11T10:49:13.437339Z","steps":["trace[1253908631] 'process raft request' (duration: 186.626678ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:49:19.390453Z","caller":"traceutil/trace.go:171","msg":"trace[1060368829] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"114.947513ms","start":"2026-05-11T10:49:19.275481Z","end":"2026-05-11T10:49:19.390428Z","steps":["trace[1060368829] 'process raft request' (duration: 114.524615ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:49:20.041225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.629149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:49:20.041328Z","caller":"traceutil/trace.go:171","msg":"trace[1911211111] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:570; }","duration":"571.757512ms","start":"2026-05-11T10:49:19.469543Z","end":"2026-05-11T10:49:20.0413Z","steps":["trace[1911211111] 'range keys from in-memory index tree' (duration: 571.546997ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:49:20.041387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:49:19.469527Z","time spent":"571.846433ms","remote":"127.0.0.1:59430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-05-11T10:49:20.041531Z","caller":"traceutil/trace.go:171","msg":"trace[1653068967] linearizableReadLoop","detail":"{readStateIndex:590; appliedIndex:589; }","duration":"249.786097ms","start":"2026-05-11T10:49:19.79172Z","end":"2026-05-11T10:49:20.041506Z","steps":["trace[1653068967] 'read index received' (duration: 220.915086ms)","trace[1653068967] 'applied index is now lower than readState.Index' (duration: 28.869821ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:49:20.041629Z","caller":"traceutil/trace.go:171","msg":"trace[653380721] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"566.03369ms","start":"2026-05-11T10:49:19.475582Z","end":"2026-05-11T10:49:20.041616Z","steps":["trace[653380721] 'process raft request' (duration: 537.135919ms)","trace[653380721] 'compare' (duration: 28.36571ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:49:20.041806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.072383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-11T10:49:20.041852Z","caller":"traceutil/trace.go:171","msg":"trace[403827473] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:571; }","duration":"250.157466ms","start":"2026-05-11T10:49:19.79168Z","end":"2026-05-11T10:49:20.041838Z","steps":["trace[403827473] 'agreement among raft nodes before linearized reading' (duration: 249.93848ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:49:20.041921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:49:19.475558Z","time spent":"566.107162ms","remote":"127.0.0.1:59372","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-05-11T10:49:20.043083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.677781ms","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-05-11T10:49:20.043122Z","caller":"traceutil/trace.go:171","msg":"trace[707146395] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"106.738609ms","start":"2026-05-11T10:49:19.936339Z","end":"2026-05-11T10:49:20.043077Z","steps":["trace[707146395] 'process raft request' (duration: 106.557016ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:49:20.043208Z","caller":"traceutil/trace.go:171","msg":"trace[1133439250] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:572; }","duration":"211.844084ms","start":"2026-05-11T10:49:19.831348Z","end":"2026-05-11T10:49:20.043192Z","steps":["trace[1133439250] 'agreement among raft nodes before linearized reading' (duration: 211.609989ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:49:20.748936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.189792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:49:20.749059Z","caller":"traceutil/trace.go:171","msg":"trace[674440624] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:576; }","duration":"358.372186ms","start":"2026-05-11T10:49:20.390649Z","end":"2026-05-11T10:49:20.749021Z","steps":["trace[674440624] 'range keys from in-memory index tree' (duration: 358.1097ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:49:20.749147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:49:20.39063Z","time spent":"358.493968ms","remote":"127.0.0.1:59180","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-05-11T10:49:20.773613Z","caller":"traceutil/trace.go:171","msg":"trace[674425223] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"353.39089ms","start":"2026-05-11T10:49:20.420189Z","end":"2026-05-11T10:49:20.77358Z","steps":["trace[674425223] 'process raft request' (duration: 352.779397ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:49:20.774186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:49:20.420162Z","time spent":"353.548094ms","remote":"127.0.0.1:59262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:50:10.508766Z","caller":"traceutil/trace.go:171","msg":"trace[317367039] linearizableReadLoop","detail":"{readStateIndex:985; appliedIndex:984; }","duration":"184.903514ms","start":"2026-05-11T10:50:10.323843Z","end":"2026-05-11T10:50:10.508747Z","steps":["trace[317367039] 'read index received' (duration: 128.219513ms)","trace[317367039] 'applied index is now lower than readState.Index' (duration: 56.680531ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:50:10.508824Z","caller":"traceutil/trace.go:171","msg":"trace[2136416959] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"212.12683ms","start":"2026-05-11T10:50:10.296671Z","end":"2026-05-11T10:50:10.508798Z","steps":["trace[2136416959] 'process raft request' (duration: 155.397319ms)","trace[2136416959] 'compare' (duration: 56.514107ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:50:10.508919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.96508ms","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-05-11T10:50:10.508944Z","caller":"traceutil/trace.go:171","msg":"trace[559099509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:954; }","duration":"206.021361ms","start":"2026-05-11T10:50:10.302916Z","end":"2026-05-11T10:50:10.508938Z","steps":["trace[559099509] 'agreement among raft nodes before linearized reading' (duration: 205.902609ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:50:10.510045Z","caller":"traceutil/trace.go:171","msg":"trace[1529019865] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"183.086516ms","start":"2026-05-11T10:50:10.326934Z","end":"2026-05-11T10:50:10.51002Z","steps":["trace[1529019865] 'process raft request' (duration: 182.957503ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:50:10.898957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.56047ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:50:10.899078Z","caller":"traceutil/trace.go:171","msg":"trace[245763817] linearizableReadLoop","detail":"{readStateIndex:987; appliedIndex:986; }","duration":"321.540476ms","start":"2026-05-11T10:50:10.577515Z","end":"2026-05-11T10:50:10.899056Z","steps":["trace[245763817] 'read index received' (duration: 116.502697ms)","trace[245763817] 'applied index is now lower than readState.Index' (duration: 205.036119ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:50:10.899225Z","caller":"traceutil/trace.go:171","msg":"trace[254932373] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"386.182674ms","start":"2026-05-11T10:50:10.512913Z","end":"2026-05-11T10:50:10.899095Z","steps":["trace[254932373] 'process raft request' (duration: 181.188905ms)","trace[254932373] 'compare' (duration: 204.0868ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:50:10.899285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.771071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:50:10.899333Z","caller":"traceutil/trace.go:171","msg":"trace[2023287621] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:956; }","duration":"321.854843ms","start":"2026-05-11T10:50:10.577468Z","end":"2026-05-11T10:50:10.899323Z","steps":["trace[2023287621] 'agreement among raft nodes before linearized reading' (duration: 321.781301ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:50:10.89937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:50:10.577451Z","time spent":"321.912454ms","remote":"127.0.0.1:59180","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-05-11T10:50:10.899384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:50:10.512887Z","time spent":"386.419759ms","remote":"127.0.0.1:59458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:50:10.911696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.795737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-11T10:50:10.911772Z","caller":"traceutil/trace.go:171","msg":"trace[345806283] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:957; }","duration":"104.92964ms","start":"2026-05-11T10:50:10.806825Z","end":"2026-05-11T10:50:10.911754Z","steps":["trace[345806283] 'agreement among raft nodes before linearized reading' (duration: 104.793368ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:50:10.912155Z","caller":"traceutil/trace.go:171","msg":"trace[355112443] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"177.953197ms","start":"2026-05-11T10:50:10.734186Z","end":"2026-05-11T10:50:10.912139Z","steps":["trace[355112443] 'process raft request' (duration: 177.300333ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:50:30.778779Z","caller":"traceutil/trace.go:171","msg":"trace[757943124] linearizableReadLoop","detail":"{readStateIndex:1055; appliedIndex:1054; }","duration":"143.739617ms","start":"2026-05-11T10:50:30.635021Z","end":"2026-05-11T10:50:30.77876Z","steps":["trace[757943124] 'read index received' (duration: 143.665925ms)","trace[757943124] 'applied index is now lower than readState.Index' (duration: 72.962µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:50:30.778906Z","caller":"traceutil/trace.go:171","msg":"trace[34510717] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"148.864492ms","start":"2026-05-11T10:50:30.630015Z","end":"2026-05-11T10:50:30.778879Z","steps":["trace[34510717] 'process raft request' (duration: 148.602626ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:50:30.778968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.924321ms","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-05-11T10:50:30.778994Z","caller":"traceutil/trace.go:171","msg":"trace[771116500] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1020; }","duration":"143.983063ms","start":"2026-05-11T10:50:30.635003Z","end":"2026-05-11T10:50:30.778987Z","steps":["trace[771116500] 'agreement among raft nodes before linearized reading' (duration: 143.84321ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:50:30.915815Z","caller":"traceutil/trace.go:171","msg":"trace[390397937] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"132.774812ms","start":"2026-05-11T10:50:30.783017Z","end":"2026-05-11T10:50:30.915791Z","steps":["trace[390397937] 'process raft request' (duration: 112.48822ms)","trace[390397937] 'compare' (duration: 20.17466ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:50:31.657835Z","caller":"traceutil/trace.go:171","msg":"trace[1696339352] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"222.223328ms","start":"2026-05-11T10:50:31.435565Z","end":"2026-05-11T10:50:31.657788Z","steps":["trace[1696339352] 'process raft request' (duration: 222.067755ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:50:32.64433Z","caller":"traceutil/trace.go:171","msg":"trace[1139354083] linearizableReadLoop","detail":"{readStateIndex:1061; appliedIndex:1060; }","duration":"254.961929ms","start":"2026-05-11T10:50:32.389325Z","end":"2026-05-11T10:50:32.644287Z","steps":["trace[1139354083] 'read index received' (duration: 199.43095ms)","trace[1139354083] 'applied index is now lower than readState.Index' (duration: 55.528969ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:50:32.644508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.159443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:50:32.644544Z","caller":"traceutil/trace.go:171","msg":"trace[1597157483] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1025; }","duration":"255.247875ms","start":"2026-05-11T10:50:32.389284Z","end":"2026-05-11T10:50:32.644532Z","steps":["trace[1597157483] 'agreement among raft nodes before linearized reading' (duration: 255.162963ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:50:32.644583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.578609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-11T10:50:32.644621Z","caller":"traceutil/trace.go:171","msg":"trace[694059028] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1025; }","duration":"219.651241ms","start":"2026-05-11T10:50:32.424958Z","end":"2026-05-11T10:50:32.644609Z","steps":["trace[694059028] 'agreement among raft nodes before linearized reading' (duration: 219.515708ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:50:33.186345Z","caller":"traceutil/trace.go:171","msg":"trace[234129965] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"155.48375ms","start":"2026-05-11T10:50:33.030847Z","end":"2026-05-11T10:50:33.186331Z","steps":["trace[234129965] 'process raft request' (duration: 155.192743ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:50:33.186667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.503411ms","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-05-11T10:50:33.186833Z","caller":"traceutil/trace.go:171","msg":"trace[1652805998] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1029; }","duration":"147.684666ms","start":"2026-05-11T10:50:33.039097Z","end":"2026-05-11T10:50:33.186782Z","steps":["trace[1652805998] 'agreement among raft nodes before linearized reading' (duration: 147.378609ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:50:33.18626Z","caller":"traceutil/trace.go:171","msg":"trace[528556148] linearizableReadLoop","detail":"{readStateIndex:1065; appliedIndex:1064; }","duration":"147.098443ms","start":"2026-05-11T10:50:33.039137Z","end":"2026-05-11T10:50:33.186235Z","steps":["trace[528556148] 'read index received' (duration: 146.946149ms)","trace[528556148] 'applied index is now lower than readState.Index' (duration: 151.204µs)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:50:33.65423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.834237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:50:33.654377Z","caller":"traceutil/trace.go:171","msg":"trace[1556938146] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1030; }","duration":"264.050102ms","start":"2026-05-11T10:50:33.390302Z","end":"2026-05-11T10:50:33.654352Z","steps":["trace[1556938146] 'range keys from in-memory index tree' (duration: 263.688845ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:51:01.433461Z","caller":"traceutil/trace.go:171","msg":"trace[1036466818] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"143.079592ms","start":"2026-05-11T10:51:01.290346Z","end":"2026-05-11T10:51:01.433425Z","steps":["trace[1036466818] 'process raft request' (duration: 142.806836ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:51:04.023077Z","caller":"traceutil/trace.go:171","msg":"trace[1778181810] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"111.780914ms","start":"2026-05-11T10:51:03.911269Z","end":"2026-05-11T10:51:04.02305Z","steps":["trace[1778181810] 'process raft request' (duration: 111.64104ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:51:04.716923Z","caller":"traceutil/trace.go:171","msg":"trace[543448228] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"173.861129ms","start":"2026-05-11T10:51:04.543029Z","end":"2026-05-11T10:51:04.71689Z","steps":["trace[543448228] 'process raft request' (duration: 173.612484ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:51:05.101849Z","caller":"traceutil/trace.go:171","msg":"trace[5738381] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"357.231162ms","start":"2026-05-11T10:51:04.744592Z","end":"2026-05-11T10:51:05.101823Z","steps":["trace[5738381] 'process raft request' (duration: 357.034418ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:51:05.102004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:51:04.744567Z","time spent":"357.359954ms","remote":"127.0.0.1:59242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":929,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:51:05.114605Z","caller":"traceutil/trace.go:171","msg":"trace[76403241] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"363.774027ms","start":"2026-05-11T10:51:04.750812Z","end":"2026-05-11T10:51:05.114586Z","steps":["trace[76403241] 'process raft request' (duration: 363.635834ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:51:05.11474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:51:04.750794Z","time spent":"363.869459ms","remote":"127.0.0.1:59458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:51:05.115361Z","caller":"traceutil/trace.go:171","msg":"trace[1709944823] linearizableReadLoop","detail":"{readStateIndex:1265; appliedIndex:1262; }","duration":"331.387924ms","start":"2026-05-11T10:51:04.783933Z","end":"2026-05-11T10:51:05.115321Z","steps":["trace[1709944823] 'read index received' (duration: 317.852273ms)","trace[1709944823] 'applied index is now lower than readState.Index' (duration: 13.532451ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:51:05.11555Z","caller":"traceutil/trace.go:171","msg":"trace[1447396741] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"362.549879ms","start":"2026-05-11T10:51:04.752989Z","end":"2026-05-11T10:51:05.115538Z","steps":["trace[1447396741] 'process raft request' (duration: 361.561187ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:51:05.115638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:51:04.75298Z","time spent":"362.600541ms","remote":"127.0.0.1:59242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:51:05.115721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.54896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:51:05.11576Z","caller":"traceutil/trace.go:171","msg":"trace[1726486101] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1221; }","duration":"267.629062ms","start":"2026-05-11T10:51:04.848122Z","end":"2026-05-11T10:51:05.115751Z","steps":["trace[1726486101] 'agreement among raft nodes before linearized reading' (duration: 267.54472ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:51:05.115961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.042769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-11T10:51:05.115986Z","caller":"traceutil/trace.go:171","msg":"trace[131258194] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1221; }","duration":"332.105591ms","start":"2026-05-11T10:51:04.783875Z","end":"2026-05-11T10:51:05.115981Z","steps":["trace[131258194] 'agreement among raft nodes before linearized reading' (duration: 332.011569ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:51:05.116004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:51:04.783847Z","time spent":"332.151862ms","remote":"127.0.0.1:59458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-11T10:51:05.116125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.143245ms","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-05-11T10:51:05.116178Z","caller":"traceutil/trace.go:171","msg":"trace[561145530] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1221; }","duration":"165.248787ms","start":"2026-05-11T10:51:04.950915Z","end":"2026-05-11T10:51:05.116163Z","steps":["trace[561145530] 'agreement among raft nodes before linearized reading' (duration: 165.056703ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:51:05.637534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.143311ms","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-05-11T10:51:05.637625Z","caller":"traceutil/trace.go:171","msg":"trace[1887772782] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1226; }","duration":"137.284873ms","start":"2026-05-11T10:51:05.500318Z","end":"2026-05-11T10:51:05.637603Z","steps":["trace[1887772782] 'range keys from in-memory index tree' (duration: 136.946886ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:51:16.963569Z","caller":"traceutil/trace.go:171","msg":"trace[161009908] linearizableReadLoop","detail":"{readStateIndex:1338; appliedIndex:1337; }","duration":"140.589747ms","start":"2026-05-11T10:51:16.822956Z","end":"2026-05-11T10:51:16.963545Z","steps":["trace[161009908] 'read index received' (duration: 140.402592ms)","trace[161009908] 'applied index is now lower than readState.Index' (duration: 186.275µs)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:51:16.963779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.780552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:51:16.963881Z","caller":"traceutil/trace.go:171","msg":"trace[736868878] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1292; }","duration":"140.954835ms","start":"2026-05-11T10:51:16.822906Z","end":"2026-05-11T10:51:16.96386Z","steps":["trace[736868878] 'agreement among raft nodes before linearized reading' (duration: 140.75965ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:51:16.963798Z","caller":"traceutil/trace.go:171","msg":"trace[1712317369] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"300.469484ms","start":"2026-05-11T10:51:16.663293Z","end":"2026-05-11T10:51:16.963763Z","steps":["trace[1712317369] 'process raft request' (duration: 300.116577ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:51:16.964113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:51:16.663269Z","time spent":"300.75206ms","remote":"127.0.0.1:59458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:54:34.92314Z","caller":"traceutil/trace.go:171","msg":"trace[727999951] linearizableReadLoop","detail":"{readStateIndex:2319; appliedIndex:2318; }","duration":"286.648363ms","start":"2026-05-11T10:54:34.636472Z","end":"2026-05-11T10:54:34.923121Z","steps":["trace[727999951] 'read index received' (duration: 15.701µs)","trace[727999951] 'applied index is now lower than readState.Index' (duration: 286.631312ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:54:34.923221Z","caller":"traceutil/trace.go:171","msg":"trace[1530380115] transaction","detail":"{read_only:false; response_revision:2232; number_of_response:1; }","duration":"286.731045ms","start":"2026-05-11T10:54:34.636452Z","end":"2026-05-11T10:54:34.923183Z","steps":["trace[1530380115] 'process raft request' (duration: 286.546591ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:54:34.923567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.977231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-11T10:54:34.92385Z","caller":"traceutil/trace.go:171","msg":"trace[702769661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2232; }","duration":"287.392859ms","start":"2026-05-11T10:54:34.636443Z","end":"2026-05-11T10:54:34.923836Z","steps":["trace[702769661] 'agreement among raft nodes before linearized reading' (duration: 286.793206ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:54:36.142803Z","caller":"traceutil/trace.go:171","msg":"trace[181998035] transaction","detail":"{read_only:false; response_revision:2236; number_of_response:1; }","duration":"411.00459ms","start":"2026-05-11T10:54:35.731772Z","end":"2026-05-11T10:54:36.142776Z","steps":["trace[181998035] 'process raft request' (duration: 410.846937ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:54:36.142963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:54:35.731757Z","time spent":"411.124663ms","remote":"127.0.0.1:59458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:54:36.284577Z","caller":"traceutil/trace.go:171","msg":"trace[573617834] transaction","detail":"{read_only:false; response_revision:2238; number_of_response:1; }","duration":"102.874659ms","start":"2026-05-11T10:54:36.18167Z","end":"2026-05-11T10:54:36.284545Z","steps":["trace[573617834] 'process raft request' (duration: 102.721395ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:54:36.297084Z","caller":"traceutil/trace.go:171","msg":"trace[1135501213] transaction","detail":"{read_only:false; response_revision:2239; number_of_response:1; }","duration":"114.299809ms","start":"2026-05-11T10:54:36.182759Z","end":"2026-05-11T10:54:36.297059Z","steps":["trace[1135501213] 'process raft request' (duration: 114.002081ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:54:36.297333Z","caller":"traceutil/trace.go:171","msg":"trace[1919731052] transaction","detail":"{read_only:false; response_revision:2241; number_of_response:1; }","duration":"113.081582ms","start":"2026-05-11T10:54:36.184242Z","end":"2026-05-11T10:54:36.297323Z","steps":["trace[1919731052] 'process raft request' (duration: 112.906288ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:54:36.297267Z","caller":"traceutil/trace.go:171","msg":"trace[1672397328] transaction","detail":"{read_only:false; response_revision:2240; number_of_response:1; }","duration":"114.531804ms","start":"2026-05-11T10:54:36.182716Z","end":"2026-05-11T10:54:36.297248Z","steps":["trace[1672397328] 'process raft request' (duration: 114.187256ms)"],"step_count":1}