{"level":"warn","ts":"2026-05-09T12:50:09.401883Z","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-09T12:50:09.402073Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.229:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.229:2380","--initial-cluster=instance=https://199.204.45.229:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.229:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.229: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-09T12:50:09.402167Z","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-09T12:50:09.402197Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-05-09T12:50:09.402226Z","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-09T12:50:09.403046Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"]} {"level":"info","ts":"2026-05-09T12:50:09.403139Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.229: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-09T12:50:09.407162Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.798011ms"} {"level":"info","ts":"2026-05-09T12:50:09.414334Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3ba9ae53cc4335db","cluster-id":"4ad2674607ff1d60"} {"level":"info","ts":"2026-05-09T12:50:09.414434Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=()"} {"level":"info","ts":"2026-05-09T12:50:09.414467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 0"} {"level":"info","ts":"2026-05-09T12:50:09.4145Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3ba9ae53cc4335db [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-09T12:50:09.414525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 1"} {"level":"info","ts":"2026-05-09T12:50:09.414577Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"warn","ts":"2026-05-09T12:50:09.419819Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-09T12:50:09.421439Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-09T12:50:09.42281Z","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-09T12:50:09.42654Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3ba9ae53cc4335db","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-09T12:50:09.427964Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3ba9ae53cc4335db","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-09T12:50:09.429049Z","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-09T12:50:09.42915Z","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-09T12:50:09.429175Z","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-09T12:50:09.429576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"info","ts":"2026-05-09T12:50:09.429708Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","added-peer-id":"3ba9ae53cc4335db","added-peer-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-05-09T12:50:09.434755Z","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-09T12:50:09.434941Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-05-09T12:50:09.435232Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3ba9ae53cc4335db","initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-09T12:50:09.435012Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-05-09T12:50:09.4353Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-09T12:50:09.515642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db is starting a new election at term 1"} {"level":"info","ts":"2026-05-09T12:50:09.515716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became pre-candidate at term 1"} {"level":"info","ts":"2026-05-09T12:50:09.515737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgPreVoteResp from 3ba9ae53cc4335db at term 1"} {"level":"info","ts":"2026-05-09T12:50:09.515757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became candidate at term 2"} {"level":"info","ts":"2026-05-09T12:50:09.515769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgVoteResp from 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-05-09T12:50:09.515785Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became leader at term 2"} {"level":"info","ts":"2026-05-09T12:50:09.515798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3ba9ae53cc4335db elected leader 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-05-09T12:50:09.516717Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3ba9ae53cc4335db","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.229:2379]}","request-path":"/0/members/3ba9ae53cc4335db/attributes","cluster-id":"4ad2674607ff1d60","publish-timeout":"7s"} {"level":"info","ts":"2026-05-09T12:50:09.516739Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T12:50:09.51688Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T12:50:09.516992Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T12:50:09.517469Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-09T12:50:09.517591Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-09T12:50:09.51928Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T12:50:09.519384Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T12:50:09.519425Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T12:50:09.521296Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-09T12:50:09.5213Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.229:2379"} {"level":"warn","ts":"2026-05-09T12:50:19.620225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.087225ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T12:50:19.620367Z","caller":"traceutil/trace.go:171","msg":"trace[513896007] linearizableReadLoop","detail":"{readStateIndex:356; appliedIndex:354; }","duration":"201.750667ms","start":"2026-05-09T12:50:19.418604Z","end":"2026-05-09T12:50:19.620355Z","steps":["trace[513896007] 'read index received' (duration: 77.110727ms)","trace[513896007] 'applied index is now lower than readState.Index' (duration: 124.63928ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:50:19.620435Z","caller":"traceutil/trace.go:171","msg":"trace[1361442908] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"248.626044ms","start":"2026-05-09T12:50:19.371802Z","end":"2026-05-09T12:50:19.620428Z","steps":["trace[1361442908] 'process raft request' (duration: 123.931704ms)","trace[1361442908] 'compare' (duration: 123.995164ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:50:19.620641Z","caller":"traceutil/trace.go:171","msg":"trace[453231756] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"234.603047ms","start":"2026-05-09T12:50:19.386029Z","end":"2026-05-09T12:50:19.620632Z","steps":["trace[453231756] 'process raft request' (duration: 234.286025ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:19.620757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.15123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-09T12:50:19.620783Z","caller":"traceutil/trace.go:171","msg":"trace[1651282295] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:343; }","duration":"202.22536ms","start":"2026-05-09T12:50:19.41855Z","end":"2026-05-09T12:50:19.620775Z","steps":["trace[1651282295] 'agreement among raft nodes before linearized reading' (duration: 202.16217ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:19.620908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.37617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-05-09T12:50:19.620936Z","caller":"traceutil/trace.go:171","msg":"trace[1127671147] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:343; }","duration":"152.456191ms","start":"2026-05-09T12:50:19.468473Z","end":"2026-05-09T12:50:19.62093Z","steps":["trace[1127671147] 'agreement among raft nodes before linearized reading' (duration: 152.392291ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:19.621116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.73905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-05-09T12:50:19.621141Z","caller":"traceutil/trace.go:171","msg":"trace[877045200] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:343; }","duration":"103.807331ms","start":"2026-05-09T12:50:19.517327Z","end":"2026-05-09T12:50:19.621135Z","steps":["trace[877045200] 'agreement among raft nodes before linearized reading' (duration: 103.771651ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:19.621198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.654002ms","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-09T12:50:19.62122Z","caller":"traceutil/trace.go:171","msg":"trace[1299963678] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:343; }","duration":"127.674733ms","start":"2026-05-09T12:50:19.493539Z","end":"2026-05-09T12:50:19.621213Z","steps":["trace[1299963678] 'agreement among raft nodes before linearized reading' (duration: 127.640362ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:21.734018Z","caller":"traceutil/trace.go:171","msg":"trace[256001741] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"100.688992ms","start":"2026-05-09T12:50:21.633302Z","end":"2026-05-09T12:50:21.733991Z","steps":["trace[256001741] 'process raft request' (duration: 100.48637ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:39.534467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.967209ms","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:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:39.534572Z","caller":"traceutil/trace.go:171","msg":"trace[1984696145] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:507; }","duration":"354.110694ms","start":"2026-05-09T12:50:39.18044Z","end":"2026-05-09T12:50:39.534551Z","steps":["trace[1984696145] 'range keys from in-memory index tree' (duration: 353.910217ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:39.534628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:39.180425Z","time spent":"354.192916ms","remote":"127.0.0.1:37146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-05-09T12:50:42.686866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"738.74471ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T12:50:42.686964Z","caller":"traceutil/trace.go:171","msg":"trace[753418160] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:610; }","duration":"701.597579ms","start":"2026-05-09T12:50:41.98535Z","end":"2026-05-09T12:50:42.686948Z","steps":["trace[753418160] 'read index received' (duration: 40.181µs)","trace[753418160] 'applied index is now lower than readState.Index' (duration: 701.556228ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:50:42.687047Z","caller":"traceutil/trace.go:171","msg":"trace[1579147160] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"774.237307ms","start":"2026-05-09T12:50:41.912798Z","end":"2026-05-09T12:50:42.687035Z","steps":["trace[1579147160] 'process raft request' (duration: 35.238519ms)","trace[1579147160] 'compare' (duration: 738.577805ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:50:42.687106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:41.912775Z","time spent":"774.301408ms","remote":"127.0.0.1:37334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T12:50:42.687285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.9328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:42.687318Z","caller":"traceutil/trace.go:171","msg":"trace[1486653602] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:588; }","duration":"701.996272ms","start":"2026-05-09T12:50:41.985309Z","end":"2026-05-09T12:50:42.687305Z","steps":["trace[1486653602] 'agreement among raft nodes before linearized reading' (duration: 701.94662ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:42.687352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:41.985287Z","time spent":"702.058694ms","remote":"127.0.0.1:37070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-09T12:50:42.699647Z","caller":"traceutil/trace.go:171","msg":"trace[1577369866] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"323.439751ms","start":"2026-05-09T12:50:42.376177Z","end":"2026-05-09T12:50:42.699616Z","steps":["trace[1577369866] 'process raft request' (duration: 323.005958ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:42.699885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:42.376157Z","time spent":"323.640788ms","remote":"127.0.0.1:37334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T12:50:42.901696Z","caller":"traceutil/trace.go:171","msg":"trace[913070355] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"197.719221ms","start":"2026-05-09T12:50:42.703945Z","end":"2026-05-09T12:50:42.901664Z","steps":["trace[913070355] 'process raft request' (duration: 193.844338ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:44.387137Z","caller":"traceutil/trace.go:171","msg":"trace[231964750] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"116.494836ms","start":"2026-05-09T12:50:44.270619Z","end":"2026-05-09T12:50:44.387114Z","steps":["trace[231964750] 'process raft request' (duration: 115.931508ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:46.840943Z","caller":"traceutil/trace.go:171","msg":"trace[219795350] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"135.563505ms","start":"2026-05-09T12:50:46.705345Z","end":"2026-05-09T12:50:46.840908Z","steps":["trace[219795350] 'process raft request' (duration: 135.353918ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:47.260864Z","caller":"traceutil/trace.go:171","msg":"trace[1208582827] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"355.368669ms","start":"2026-05-09T12:50:46.905462Z","end":"2026-05-09T12:50:47.260831Z","steps":["trace[1208582827] 'read index received' (duration: 354.295426ms)","trace[1208582827] 'applied index is now lower than readState.Index' (duration: 1.071623ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:50:47.260956Z","caller":"traceutil/trace.go:171","msg":"trace[2011296174] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"370.39521ms","start":"2026-05-09T12:50:46.890495Z","end":"2026-05-09T12:50:47.26089Z","steps":["trace[2011296174] 'process raft request' (duration: 369.558214ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:47.261229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.73163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hrk8c\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-09T12:50:47.261284Z","caller":"traceutil/trace.go:171","msg":"trace[2080722297] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hrk8c; range_end:; response_count:1; response_revision:619; }","duration":"355.869194ms","start":"2026-05-09T12:50:46.905398Z","end":"2026-05-09T12:50:47.261267Z","steps":["trace[2080722297] 'agreement among raft nodes before linearized reading' (duration: 355.615816ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:47.261333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:46.905368Z","time spent":"355.955017ms","remote":"127.0.0.1:37248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-hrk8c\" "} {"level":"warn","ts":"2026-05-09T12:50:47.261594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.869849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-09T12:50:47.26164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.583733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:47.261732Z","caller":"traceutil/trace.go:171","msg":"trace[2021515005] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:619; }","duration":"275.734568ms","start":"2026-05-09T12:50:46.985975Z","end":"2026-05-09T12:50:47.26171Z","steps":["trace[2021515005] 'agreement among raft nodes before linearized reading' (duration: 275.47089ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:47.261732Z","caller":"traceutil/trace.go:171","msg":"trace[727899623] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:619; }","duration":"332.047404ms","start":"2026-05-09T12:50:46.929648Z","end":"2026-05-09T12:50:47.261696Z","steps":["trace[727899623] 'agreement among raft nodes before linearized reading' (duration: 331.651492ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:47.261805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:46.929607Z","time spent":"332.181438ms","remote":"127.0.0.1:37334","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-05-09T12:50:47.261968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:46.890456Z","time spent":"370.621636ms","remote":"127.0.0.1:37146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T12:50:47.262692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.133079ms","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-05-09T12:50:47.262765Z","caller":"traceutil/trace.go:171","msg":"trace[583885174] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:619; }","duration":"171.221162ms","start":"2026-05-09T12:50:47.091521Z","end":"2026-05-09T12:50:47.262742Z","steps":["trace[583885174] 'agreement among raft nodes before linearized reading' (duration: 169.83457ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:47.387316Z","caller":"traceutil/trace.go:171","msg":"trace[1223045211] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"110.006896ms","start":"2026-05-09T12:50:47.277282Z","end":"2026-05-09T12:50:47.387289Z","steps":["trace[1223045211] 'process raft request' (duration: 109.917984ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:47.387548Z","caller":"traceutil/trace.go:171","msg":"trace[1463468095] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"119.227366ms","start":"2026-05-09T12:50:47.268307Z","end":"2026-05-09T12:50:47.387534Z","steps":["trace[1463468095] 'process raft request' (duration: 118.641728ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:48.400315Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869281671514902,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T12:50:48.901246Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869281671514902,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T12:50:49.22259Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.835479382s","expected-duration":"1s"} {"level":"info","ts":"2026-05-09T12:50:49.246502Z","caller":"traceutil/trace.go:171","msg":"trace[1677755635] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"1.928462529s","start":"2026-05-09T12:50:47.317861Z","end":"2026-05-09T12:50:49.246323Z","steps":["trace[1677755635] 'process raft request' (duration: 1.905080994s)","trace[1677755635] 'compare' (duration: 22.056835ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:50:49.246703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:47.317831Z","time spent":"1.928785227s","remote":"127.0.0.1:37302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T12:50:49.25084Z","caller":"traceutil/trace.go:171","msg":"trace[1603198133] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:646; }","duration":"1.351427824s","start":"2026-05-09T12:50:47.899391Z","end":"2026-05-09T12:50:49.250819Z","steps":["trace[1603198133] 'read index received' (duration: 1.323489904s)","trace[1603198133] 'applied index is now lower than readState.Index' (duration: 27.9363ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:50:49.251272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.351868097s","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-09T12:50:49.251308Z","caller":"traceutil/trace.go:171","msg":"trace[1598489872] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:623; }","duration":"1.351926188s","start":"2026-05-09T12:50:47.899373Z","end":"2026-05-09T12:50:49.2513Z","steps":["trace[1598489872] 'agreement among raft nodes before linearized reading' (duration: 1.351712372s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:49.251303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.265387784s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T12:50:49.251336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:47.899286Z","time spent":"1.352042812s","remote":"127.0.0.1:37334","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-05-09T12:50:49.251366Z","caller":"traceutil/trace.go:171","msg":"trace[1171582062] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"1.265489147s","start":"2026-05-09T12:50:47.985854Z","end":"2026-05-09T12:50:49.251344Z","steps":["trace[1171582062] 'agreement among raft nodes before linearized reading' (duration: 1.265389004s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:49.251406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:47.985827Z","time spent":"1.265572619s","remote":"127.0.0.1:37070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T12:50:49.251764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.726053ms","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-09T12:50:49.251799Z","caller":"traceutil/trace.go:171","msg":"trace[631572828] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:623; }","duration":"405.816256ms","start":"2026-05-09T12:50:48.845972Z","end":"2026-05-09T12:50:49.251788Z","steps":["trace[631572828] 'agreement among raft nodes before linearized reading' (duration: 405.708593ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:49.251827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:48.845945Z","time spent":"405.875828ms","remote":"127.0.0.1:37334","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-05-09T12:50:50.206432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.480455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:50.20653Z","caller":"traceutil/trace.go:171","msg":"trace[1949455046] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:636; }","duration":"100.627198ms","start":"2026-05-09T12:50:50.105884Z","end":"2026-05-09T12:50:50.206511Z","steps":["trace[1949455046] 'range keys from in-memory index tree' (duration: 100.415112ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:50.206734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.67294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:50.206775Z","caller":"traceutil/trace.go:171","msg":"trace[1151997812] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:636; }","duration":"100.759703ms","start":"2026-05-09T12:50:50.106005Z","end":"2026-05-09T12:50:50.206765Z","steps":["trace[1151997812] 'range keys from in-memory index tree' (duration: 100.560126ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:51.289569Z","caller":"traceutil/trace.go:171","msg":"trace[187905896] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"137.576945ms","start":"2026-05-09T12:50:51.151958Z","end":"2026-05-09T12:50:51.289535Z","steps":["trace[187905896] 'process raft request' (duration: 137.368899ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:52.130992Z","caller":"traceutil/trace.go:171","msg":"trace[1470289862] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"180.29878ms","start":"2026-05-09T12:50:51.950611Z","end":"2026-05-09T12:50:52.13091Z","steps":["trace[1470289862] 'process raft request' (duration: 147.68825ms)","trace[1470289862] 'compare' (duration: 32.249529ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:50:52.131074Z","caller":"traceutil/trace.go:171","msg":"trace[1427235467] linearizableReadLoop","detail":"{readStateIndex:700; appliedIndex:698; }","duration":"144.101136ms","start":"2026-05-09T12:50:51.986929Z","end":"2026-05-09T12:50:52.131031Z","steps":["trace[1427235467] 'read index received' (duration: 111.366213ms)","trace[1427235467] 'applied index is now lower than readState.Index' (duration: 32.732773ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:50:52.131229Z","caller":"traceutil/trace.go:171","msg":"trace[271880892] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"180.548687ms","start":"2026-05-09T12:50:51.950629Z","end":"2026-05-09T12:50:52.131178Z","steps":["trace[271880892] 'process raft request' (duration: 180.178547ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:52.131323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.367973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:50:52.131429Z","caller":"traceutil/trace.go:171","msg":"trace[1958583727] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:675; }","duration":"144.545078ms","start":"2026-05-09T12:50:51.986874Z","end":"2026-05-09T12:50:52.131419Z","steps":["trace[1958583727] 'agreement among raft nodes before linearized reading' (duration: 144.290201ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:52.42114Z","caller":"traceutil/trace.go:171","msg":"trace[146912283] linearizableReadLoop","detail":"{readStateIndex:701; appliedIndex:700; }","duration":"273.424938ms","start":"2026-05-09T12:50:52.147689Z","end":"2026-05-09T12:50:52.421114Z","steps":["trace[146912283] 'read index received' (duration: 273.15616ms)","trace[146912283] 'applied index is now lower than readState.Index' (duration: 267.348µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:50:52.421216Z","caller":"traceutil/trace.go:171","msg":"trace[1861449747] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"274.992123ms","start":"2026-05-09T12:50:52.146177Z","end":"2026-05-09T12:50:52.421169Z","steps":["trace[1861449747] 'process raft request' (duration: 274.779197ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:50:52.421622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.874321ms","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-05-09T12:50:52.421757Z","caller":"traceutil/trace.go:171","msg":"trace[1972918128] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:676; }","duration":"274.074886ms","start":"2026-05-09T12:50:52.147642Z","end":"2026-05-09T12:50:52.421716Z","steps":["trace[1972918128] 'agreement among raft nodes before linearized reading' (duration: 273.620763ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:50:52.633839Z","caller":"traceutil/trace.go:171","msg":"trace[1958522513] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"197.970274ms","start":"2026-05-09T12:50:52.435815Z","end":"2026-05-09T12:50:52.633785Z","steps":["trace[1958522513] 'process raft request' (duration: 197.714817ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:51:09.583244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.325473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:51:09.583357Z","caller":"traceutil/trace.go:171","msg":"trace[1733094453] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:796; }","duration":"597.487067ms","start":"2026-05-09T12:51:08.985855Z","end":"2026-05-09T12:51:09.583342Z","steps":["trace[1733094453] 'range keys from in-memory index tree' (duration: 597.247791ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:51:09.58373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:51:08.985833Z","time spent":"597.887766ms","remote":"127.0.0.1:37070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-09T12:51:09.58337Z","caller":"traceutil/trace.go:171","msg":"trace[1891005504] linearizableReadLoop","detail":"{readStateIndex:827; appliedIndex:826; }","duration":"184.637496ms","start":"2026-05-09T12:51:09.398699Z","end":"2026-05-09T12:51:09.583336Z","steps":["trace[1891005504] 'read index received' (duration: 173.845862ms)","trace[1891005504] 'applied index is now lower than readState.Index' (duration: 10.790044ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:51:09.583832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.674497ms","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-05-09T12:51:09.583914Z","caller":"traceutil/trace.go:171","msg":"trace[929020007] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:796; }","duration":"722.840001ms","start":"2026-05-09T12:51:08.861062Z","end":"2026-05-09T12:51:09.583902Z","steps":["trace[929020007] 'range keys from in-memory index tree' (duration: 721.717504ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:51:09.583976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:51:08.861044Z","time spent":"722.902922ms","remote":"127.0.0.1:37334","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-05-09T12:51:09.583599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.892652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-09T12:51:09.584183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.61325ms","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-09T12:51:09.584201Z","caller":"traceutil/trace.go:171","msg":"trace[292898139] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:797; }","duration":"185.488017ms","start":"2026-05-09T12:51:09.398631Z","end":"2026-05-09T12:51:09.584119Z","steps":["trace[292898139] 'agreement among raft nodes before linearized reading' (duration: 184.80006ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:51:09.584226Z","caller":"traceutil/trace.go:171","msg":"trace[579766063] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:797; }","duration":"176.673041ms","start":"2026-05-09T12:51:09.407537Z","end":"2026-05-09T12:51:09.58421Z","steps":["trace[579766063] 'agreement among raft nodes before linearized reading' (duration: 176.589599ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:51:09.583535Z","caller":"traceutil/trace.go:171","msg":"trace[1533105385] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"540.234863ms","start":"2026-05-09T12:51:09.043249Z","end":"2026-05-09T12:51:09.583484Z","steps":["trace[1533105385] 'process raft request' (duration: 529.314605ms)","trace[1533105385] 'compare' (duration: 10.333843ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:51:09.584073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.813436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-09T12:51:09.584406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:51:09.043224Z","time spent":"541.074563ms","remote":"127.0.0.1:37302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T12:51:09.584458Z","caller":"traceutil/trace.go:171","msg":"trace[728828145] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:797; }","duration":"182.236207ms","start":"2026-05-09T12:51:09.40221Z","end":"2026-05-09T12:51:09.584446Z","steps":["trace[728828145] 'agreement among raft nodes before linearized reading' (duration: 181.689814ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:53:08.700191Z","caller":"traceutil/trace.go:171","msg":"trace[1493186538] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"178.685776ms","start":"2026-05-09T12:53:08.521475Z","end":"2026-05-09T12:53:08.700161Z","steps":["trace[1493186538] 'process raft request' (duration: 178.519844ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:53:08.708636Z","caller":"traceutil/trace.go:171","msg":"trace[135015034] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"187.06594ms","start":"2026-05-09T12:53:08.521532Z","end":"2026-05-09T12:53:08.708598Z","steps":["trace[135015034] 'process raft request' (duration: 186.910368ms)"],"step_count":1}