{"level":"warn","ts":"2026-05-20T11:58:43.319544Z","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-20T11:58:43.319623Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.19: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.19:2380","--initial-cluster=instance=https://199.204.45.19:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.19:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.19: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-20T11:58:43.319768Z","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-20T11:58:43.319784Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-05-20T11:58:43.319803Z","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-20T11:58:43.320654Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"]} {"level":"info","ts":"2026-05-20T11:58:43.320768Z","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.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.19: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-20T11:58:43.326259Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.227588ms"} {"level":"info","ts":"2026-05-20T11:58:43.336288Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a847c2e9c7010db6","cluster-id":"2b11a68e27507b05"} {"level":"info","ts":"2026-05-20T11:58:43.336353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=()"} {"level":"info","ts":"2026-05-20T11:58:43.33638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 0"} {"level":"info","ts":"2026-05-20T11:58:43.336394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a847c2e9c7010db6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-20T11:58:43.336403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 1"} {"level":"info","ts":"2026-05-20T11:58:43.336483Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"warn","ts":"2026-05-20T11:58:43.342928Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-20T11:58:43.34495Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-20T11:58:43.346495Z","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-20T11:58:43.348939Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a847c2e9c7010db6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-20T11:58:43.349189Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a847c2e9c7010db6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-20T11:58:43.349434Z","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-20T11:58:43.34952Z","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-20T11:58:43.34953Z","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-20T11:58:43.350273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"info","ts":"2026-05-20T11:58:43.350564Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","added-peer-id":"a847c2e9c7010db6","added-peer-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-05-20T11:58:43.354633Z","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-20T11:58:43.354907Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a847c2e9c7010db6","initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-20T11:58:43.354952Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-20T11:58:43.355052Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-05-20T11:58:43.355074Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-05-20T11:58:43.537217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 is starting a new election at term 1"} {"level":"info","ts":"2026-05-20T11:58:43.537289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-20T11:58:43.537314Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgPreVoteResp from a847c2e9c7010db6 at term 1"} {"level":"info","ts":"2026-05-20T11:58:43.537329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became candidate at term 2"} {"level":"info","ts":"2026-05-20T11:58:43.537336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgVoteResp from a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-05-20T11:58:43.537346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became leader at term 2"} {"level":"info","ts":"2026-05-20T11:58:43.537388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a847c2e9c7010db6 elected leader a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-05-20T11:58:43.538617Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T11:58:43.539332Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a847c2e9c7010db6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.19:2379]}","request-path":"/0/members/a847c2e9c7010db6/attributes","cluster-id":"2b11a68e27507b05","publish-timeout":"7s"} {"level":"info","ts":"2026-05-20T11:58:43.54224Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T11:58:43.542315Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T11:58:43.544546Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-20T11:58:43.544637Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-20T11:58:43.544687Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-20T11:58:43.544849Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.19:2379"} {"level":"info","ts":"2026-05-20T11:58:43.545326Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T11:58:43.545423Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T11:58:43.545446Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T11:58:53.236696Z","caller":"traceutil/trace.go:171","msg":"trace[796244080] transaction","detail":"{read_only:false; response_revision:331; number_of_response:1; }","duration":"546.741719ms","start":"2026-05-20T11:58:52.689932Z","end":"2026-05-20T11:58:53.236674Z","steps":["trace[796244080] 'process raft request' (duration: 546.600636ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:58:53.237086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:58:52.689901Z","time spent":"546.873501ms","remote":"127.0.0.1:33622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T11:59:01.954715Z","caller":"traceutil/trace.go:171","msg":"trace[1729123851] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"110.379214ms","start":"2026-05-20T11:59:01.844308Z","end":"2026-05-20T11:59:01.954687Z","steps":["trace[1729123851] 'process raft request' (duration: 106.058559ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:12.240448Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151188528466947,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T11:59:12.741301Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151188528466947,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T11:59:12.857172Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.130396073s","expected-duration":"1s"} {"level":"info","ts":"2026-05-20T11:59:12.857606Z","caller":"traceutil/trace.go:171","msg":"trace[367577961] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"1.130922093s","start":"2026-05-20T11:59:11.72666Z","end":"2026-05-20T11:59:12.857583Z","steps":["trace[367577961] 'process raft request' (duration: 1.130748069s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:12.857977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:11.726635Z","time spent":"1.131044404s","remote":"127.0.0.1:33692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T11:59:13.29521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.613107ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-20T11:59:13.295338Z","caller":"traceutil/trace.go:171","msg":"trace[1025236797] linearizableReadLoop","detail":"{readStateIndex:484; appliedIndex:483; }","duration":"1.555273359s","start":"2026-05-20T11:59:11.740047Z","end":"2026-05-20T11:59:13.29532Z","steps":["trace[1025236797] 'read index received' (duration: 1.118424366s)","trace[1025236797] 'applied index is now lower than readState.Index' (duration: 436.847553ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T11:59:13.295472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.555414231s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-20T11:59:13.295499Z","caller":"traceutil/trace.go:171","msg":"trace[722152143] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:470; }","duration":"1.555513833s","start":"2026-05-20T11:59:11.739976Z","end":"2026-05-20T11:59:13.29549Z","steps":["trace[722152143] 'agreement among raft nodes before linearized reading' (duration: 1.555432471s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:13.295536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:11.73996Z","time spent":"1.555566743s","remote":"127.0.0.1:33692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-20T11:59:13.295529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.54976431s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T11:59:13.295605Z","caller":"traceutil/trace.go:171","msg":"trace[61559447] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:470; }","duration":"1.549866601s","start":"2026-05-20T11:59:11.745719Z","end":"2026-05-20T11:59:13.295585Z","steps":["trace[61559447] 'agreement among raft nodes before linearized reading' (duration: 1.549731749s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:13.295647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:11.745711Z","time spent":"1.549926892s","remote":"127.0.0.1:33412","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-20T11:59:13.29589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.295376219s","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-20T11:59:13.29592Z","caller":"traceutil/trace.go:171","msg":"trace[1583194468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:470; }","duration":"1.2954447s","start":"2026-05-20T11:59:12.000465Z","end":"2026-05-20T11:59:13.29591Z","steps":["trace[1583194468] 'agreement among raft nodes before linearized reading' (duration: 1.295385789s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:13.295947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:12.000444Z","time spent":"1.295498171s","remote":"127.0.0.1:33692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-20T11:59:13.458156Z","caller":"traceutil/trace.go:171","msg":"trace[53928106] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"119.72784ms","start":"2026-05-20T11:59:13.338394Z","end":"2026-05-20T11:59:13.458122Z","steps":["trace[53928106] 'process raft request' (duration: 55.733952ms)","trace[53928106] 'compare' (duration: 63.863226ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T11:59:19.248476Z","caller":"traceutil/trace.go:171","msg":"trace[56794577] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"366.338005ms","start":"2026-05-20T11:59:18.882112Z","end":"2026-05-20T11:59:19.24845Z","steps":["trace[56794577] 'process raft request' (duration: 366.141281ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:19.248659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:18.882097Z","time spent":"366.459707ms","remote":"127.0.0.1:33692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T11:59:21.601316Z","caller":"traceutil/trace.go:171","msg":"trace[1975185887] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"112.919475ms","start":"2026-05-20T11:59:21.488377Z","end":"2026-05-20T11:59:21.601296Z","steps":["trace[1975185887] 'process raft request' (duration: 112.522429ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T11:59:22.612531Z","caller":"traceutil/trace.go:171","msg":"trace[1385001525] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"656.349636ms","start":"2026-05-20T11:59:21.956149Z","end":"2026-05-20T11:59:22.612499Z","steps":["trace[1385001525] 'process raft request' (duration: 656.171314ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:22.612705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:21.956127Z","time spent":"656.494639ms","remote":"127.0.0.1:33462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T11:59:22.624127Z","caller":"traceutil/trace.go:171","msg":"trace[281636394] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"654.940272ms","start":"2026-05-20T11:59:21.969162Z","end":"2026-05-20T11:59:22.624102Z","steps":["trace[281636394] 'process raft request' (duration: 654.83772ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T11:59:22.62419Z","caller":"traceutil/trace.go:171","msg":"trace[1248387341] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"662.504719ms","start":"2026-05-20T11:59:21.96167Z","end":"2026-05-20T11:59:22.624175Z","steps":["trace[1248387341] 'process raft request' (duration: 662.209424ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T11:59:22.624294Z","caller":"traceutil/trace.go:171","msg":"trace[1611423206] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"644.027388ms","start":"2026-05-20T11:59:21.980246Z","end":"2026-05-20T11:59:22.624273Z","steps":["trace[1611423206] 'process raft request' (duration: 643.901106ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:22.624281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:21.969148Z","time spent":"655.051693ms","remote":"127.0.0.1:33462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T11:59:22.624363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:21.980194Z","time spent":"644.124609ms","remote":"127.0.0.1:33462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T11:59:22.624328Z","caller":"traceutil/trace.go:171","msg":"trace[396438237] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"654.791899ms","start":"2026-05-20T11:59:21.969452Z","end":"2026-05-20T11:59:22.624244Z","steps":["trace[396438237] 'process raft request' (duration: 654.582936ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T11:59:22.624447Z","caller":"traceutil/trace.go:171","msg":"trace[265691428] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"636.135644ms","start":"2026-05-20T11:59:21.988305Z","end":"2026-05-20T11:59:22.624441Z","steps":["trace[265691428] 'process raft request' (duration: 635.926141ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:22.624477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:21.988293Z","time spent":"636.169486ms","remote":"127.0.0.1:33462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T11:59:22.624481Z","caller":"traceutil/trace.go:171","msg":"trace[2010855768] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"653.548528ms","start":"2026-05-20T11:59:21.970873Z","end":"2026-05-20T11:59:22.624422Z","steps":["trace[2010855768] 'process raft request' (duration: 653.191342ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T11:59:22.624581Z","caller":"traceutil/trace.go:171","msg":"trace[1118353136] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"616.727138ms","start":"2026-05-20T11:59:22.007846Z","end":"2026-05-20T11:59:22.624573Z","steps":["trace[1118353136] 'process raft request' (duration: 616.457363ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:22.624571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:21.969444Z","time spent":"655.029154ms","remote":"127.0.0.1:33462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T11:59:22.624614Z","caller":"traceutil/trace.go:171","msg":"trace[710366895] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"642.325679ms","start":"2026-05-20T11:59:21.98228Z","end":"2026-05-20T11:59:22.624606Z","steps":["trace[710366895] 'process raft request' (duration: 641.895812ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T11:59:22.624654Z","caller":"traceutil/trace.go:171","msg":"trace[426420393] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"628.877642ms","start":"2026-05-20T11:59:21.995769Z","end":"2026-05-20T11:59:22.624647Z","steps":["trace[426420393] 'process raft request' (duration: 628.495786ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:22.624665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:21.970869Z","time spent":"653.706981ms","remote":"127.0.0.1:33462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T11:59:22.624686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:21.995755Z","time spent":"628.919542ms","remote":"127.0.0.1:33462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T11:59:22.624696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:21.98227Z","time spent":"642.40089ms","remote":"127.0.0.1:33462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T11:59:22.624622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:22.007812Z","time spent":"616.792939ms","remote":"127.0.0.1:33462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T11:59:22.624775Z","caller":"traceutil/trace.go:171","msg":"trace[390224286] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"599.774054ms","start":"2026-05-20T11:59:22.024989Z","end":"2026-05-20T11:59:22.624763Z","steps":["trace[390224286] 'process raft request' (duration: 599.437788ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:22.624803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:22.024955Z","time spent":"599.834894ms","remote":"127.0.0.1:33462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T11:59:22.624844Z","caller":"traceutil/trace.go:171","msg":"trace[1429314147] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"457.468298ms","start":"2026-05-20T11:59:22.16736Z","end":"2026-05-20T11:59:22.624829Z","steps":["trace[1429314147] 'process raft request' (duration: 457.128622ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:22.624903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:22.167317Z","time spent":"457.55987ms","remote":"127.0.0.1:33462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T11:59:22.626004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:21.961661Z","time spent":"662.58664ms","remote":"127.0.0.1:33462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T11:59:27.657164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.566515ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T11:59:27.659427Z","caller":"traceutil/trace.go:171","msg":"trace[1087718560] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"250.643834ms","start":"2026-05-20T11:59:27.406704Z","end":"2026-05-20T11:59:27.657347Z","steps":["trace[1087718560] 'process raft request' (duration: 45.834526ms)","trace[1087718560] 'compare' (duration: 204.422322ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T11:59:28.240299Z","caller":"traceutil/trace.go:171","msg":"trace[538203228] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"122.446738ms","start":"2026-05-20T11:59:28.117816Z","end":"2026-05-20T11:59:28.240263Z","steps":["trace[538203228] 'process raft request' (duration: 121.791367ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T11:59:28.995849Z","caller":"traceutil/trace.go:171","msg":"trace[1059279750] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"234.626271ms","start":"2026-05-20T11:59:28.761191Z","end":"2026-05-20T11:59:28.995817Z","steps":["trace[1059279750] 'process raft request' (duration: 232.837802ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:29.816352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.775696ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"warn","ts":"2026-05-20T11:59:29.816282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.005814ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T11:59:29.816463Z","caller":"traceutil/trace.go:171","msg":"trace[1945555116] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"530.953285ms","start":"2026-05-20T11:59:29.285482Z","end":"2026-05-20T11:59:29.816435Z","steps":["trace[1945555116] 'read index received' (duration: 393.957155ms)","trace[1945555116] 'applied index is now lower than readState.Index' (duration: 136.99508ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T11:59:29.816462Z","caller":"traceutil/trace.go:171","msg":"trace[1608835833] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:628; }","duration":"415.193328ms","start":"2026-05-20T11:59:29.401241Z","end":"2026-05-20T11:59:29.816435Z","steps":["trace[1608835833] 'range keys from in-memory index tree' (duration: 414.956823ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T11:59:29.816544Z","caller":"traceutil/trace.go:171","msg":"trace[1350638024] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"757.753117ms","start":"2026-05-20T11:59:29.05878Z","end":"2026-05-20T11:59:29.816533Z","steps":["trace[1350638024] 'process raft request' (duration: 620.726037ms)","trace[1350638024] 'compare' (duration: 136.276917ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T11:59:29.81659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:29.058743Z","time spent":"757.820628ms","remote":"127.0.0.1:33768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T11:59:29.816775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.297621ms","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-20T11:59:29.8168Z","caller":"traceutil/trace.go:171","msg":"trace[1499211159] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:629; }","duration":"531.374481ms","start":"2026-05-20T11:59:29.285418Z","end":"2026-05-20T11:59:29.816792Z","steps":["trace[1499211159] 'agreement among raft nodes before linearized reading' (duration: 531.237309ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:29.81682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:29.285369Z","time spent":"531.446023ms","remote":"127.0.0.1:33692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-20T11:59:29.81683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.630705ms","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-20T11:59:29.816873Z","caller":"traceutil/trace.go:171","msg":"trace[87549606] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:629; }","duration":"113.715876ms","start":"2026-05-20T11:59:29.703147Z","end":"2026-05-20T11:59:29.816863Z","steps":["trace[87549606] 'agreement among raft nodes before linearized reading' (duration: 113.516543ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:29.817171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.040104ms","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-20T11:59:29.817202Z","caller":"traceutil/trace.go:171","msg":"trace[1706229431] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:629; }","duration":"410.115366ms","start":"2026-05-20T11:59:29.407079Z","end":"2026-05-20T11:59:29.817195Z","steps":["trace[1706229431] 'agreement among raft nodes before linearized reading' (duration: 410.069835ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:29.817221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:29.407056Z","time spent":"410.161126ms","remote":"127.0.0.1:33692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-20T11:59:29.817921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.446048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-20T11:59:29.817966Z","caller":"traceutil/trace.go:171","msg":"trace[1111490252] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:629; }","duration":"423.550171ms","start":"2026-05-20T11:59:29.394402Z","end":"2026-05-20T11:59:29.817953Z","steps":["trace[1111490252] 'agreement among raft nodes before linearized reading' (duration: 422.297111ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:29.81802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:29.394376Z","time spent":"423.634171ms","remote":"127.0.0.1:33692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-20T11:59:30.047218Z","caller":"traceutil/trace.go:171","msg":"trace[33755100] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"223.655767ms","start":"2026-05-20T11:59:29.823536Z","end":"2026-05-20T11:59:30.047192Z","steps":["trace[33755100] 'process raft request' (duration: 172.5295ms)","trace[33755100] 'compare' (duration: 50.946704ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T11:59:30.047447Z","caller":"traceutil/trace.go:171","msg":"trace[1215568079] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:648; }","duration":"221.279348ms","start":"2026-05-20T11:59:29.826142Z","end":"2026-05-20T11:59:30.047421Z","steps":["trace[1215568079] 'read index received' (duration: 68.414148ms)","trace[1215568079] 'applied index is now lower than readState.Index' (duration: 152.86397ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T11:59:30.047483Z","caller":"traceutil/trace.go:171","msg":"trace[422188108] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"223.26951ms","start":"2026-05-20T11:59:29.824198Z","end":"2026-05-20T11:59:30.047467Z","steps":["trace[422188108] 'process raft request' (duration: 222.926315ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:30.047563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.40354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T11:59:30.047605Z","caller":"traceutil/trace.go:171","msg":"trace[1783396260] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:633; }","duration":"221.484941ms","start":"2026-05-20T11:59:29.826107Z","end":"2026-05-20T11:59:30.047592Z","steps":["trace[1783396260] 'agreement among raft nodes before linearized reading' (duration: 221.40365ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T11:59:30.048464Z","caller":"traceutil/trace.go:171","msg":"trace[333754506] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"222.966035ms","start":"2026-05-20T11:59:29.825456Z","end":"2026-05-20T11:59:30.048422Z","steps":["trace[333754506] 'process raft request' (duration: 221.901808ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T11:59:30.284029Z","caller":"traceutil/trace.go:171","msg":"trace[1248027739] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"194.1698ms","start":"2026-05-20T11:59:30.089827Z","end":"2026-05-20T11:59:30.283997Z","steps":["trace[1248027739] 'process raft request' (duration: 193.992637ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T11:59:31.739664Z","caller":"traceutil/trace.go:171","msg":"trace[1739001573] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:657; }","duration":"386.89104ms","start":"2026-05-20T11:59:31.352741Z","end":"2026-05-20T11:59:31.739632Z","steps":["trace[1739001573] 'read index received' (duration: 385.495788ms)","trace[1739001573] 'applied index is now lower than readState.Index' (duration: 1.393822ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T11:59:31.74003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.256065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-wxfkr\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-20T11:59:31.740013Z","caller":"traceutil/trace.go:171","msg":"trace[1599589323] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"691.642257ms","start":"2026-05-20T11:59:31.048321Z","end":"2026-05-20T11:59:31.739963Z","steps":["trace[1599589323] 'process raft request' (duration: 690.58946ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T11:59:31.740109Z","caller":"traceutil/trace.go:171","msg":"trace[1765182128] range","detail":"{range_begin:/registry/pods/kube-system/cilium-wxfkr; range_end:; response_count:1; response_revision:640; }","duration":"387.407238ms","start":"2026-05-20T11:59:31.352688Z","end":"2026-05-20T11:59:31.740095Z","steps":["trace[1765182128] 'agreement among raft nodes before linearized reading' (duration: 387.193374ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:31.740244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:31.352665Z","time spent":"387.535529ms","remote":"127.0.0.1:33598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-wxfkr\" "} {"level":"warn","ts":"2026-05-20T11:59:31.740407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:31.048285Z","time spent":"691.86829ms","remote":"127.0.0.1:33514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T11:59:31.939303Z","caller":"traceutil/trace.go:171","msg":"trace[946605402] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"179.829404ms","start":"2026-05-20T11:59:31.759403Z","end":"2026-05-20T11:59:31.939232Z","steps":["trace[946605402] 'process raft request' (duration: 179.59399ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:32.510449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.701675ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T11:59:32.510931Z","caller":"traceutil/trace.go:171","msg":"trace[2079861153] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"707.825105ms","start":"2026-05-20T11:59:31.803071Z","end":"2026-05-20T11:59:32.510896Z","steps":["trace[2079861153] 'process raft request' (duration: 307.603382ms)","trace[2079861153] 'compare' (duration: 399.441501ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T11:59:32.510942Z","caller":"traceutil/trace.go:171","msg":"trace[1028774611] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:658; }","duration":"611.925684ms","start":"2026-05-20T11:59:31.898999Z","end":"2026-05-20T11:59:32.510924Z","steps":["trace[1028774611] 'read index received' (duration: 40.081245ms)","trace[1028774611] 'applied index is now lower than readState.Index' (duration: 571.842729ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T11:59:32.511003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:31.803029Z","time spent":"707.948508ms","remote":"127.0.0.1:33660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T11:59:34.512819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.613793996s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-20T11:59:34.513747Z","caller":"traceutil/trace.go:171","msg":"trace[783900432] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:642; }","duration":"2.614791861s","start":"2026-05-20T11:59:31.898926Z","end":"2026-05-20T11:59:34.513718Z","steps":["trace[783900432] 'agreement among raft nodes before linearized reading' (duration: 612.106577ms)","trace[783900432] 'range keys from in-memory index tree' (duration: 2.001519536s)"],"step_count":2} {"level":"warn","ts":"2026-05-20T11:59:34.513817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:31.898902Z","time spent":"2.614900453s","remote":"127.0.0.1:33692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-20T11:59:34.512928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.002343249s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-20T11:59:34.513937Z","caller":"traceutil/trace.go:171","msg":"trace[391446120] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:660; }","duration":"2.002918877s","start":"2026-05-20T11:59:32.510979Z","end":"2026-05-20T11:59:34.513898Z","steps":["trace[391446120] 'read index received' (duration: 69.482µs)","trace[391446120] 'applied index is now lower than readState.Index' (duration: 2.002845495s)"],"step_count":2} {"level":"warn","ts":"2026-05-20T11:59:34.514179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.998307856s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-05-20T11:59:34.514155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.461605645s","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-20T11:59:34.514226Z","caller":"traceutil/trace.go:171","msg":"trace[1934774037] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:642; }","duration":"1.998380896s","start":"2026-05-20T11:59:32.515832Z","end":"2026-05-20T11:59:34.514213Z","steps":["trace[1934774037] 'agreement among raft nodes before linearized reading' (duration: 1.998298945s)"],"step_count":1} {"level":"info","ts":"2026-05-20T11:59:34.514251Z","caller":"traceutil/trace.go:171","msg":"trace[2024708992] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:642; }","duration":"2.461738646s","start":"2026-05-20T11:59:32.052488Z","end":"2026-05-20T11:59:34.514227Z","steps":["trace[2024708992] 'agreement among raft nodes before linearized reading' (duration: 2.461429191s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:34.51427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:32.515818Z","time spent":"1.998441668s","remote":"127.0.0.1:33622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-05-20T11:59:34.514271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.462342696s","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-20T11:59:34.514315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:32.052481Z","time spent":"2.461822938s","remote":"127.0.0.1:33692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-20T11:59:34.514428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.46260223s","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-20T11:59:34.514473Z","caller":"traceutil/trace.go:171","msg":"trace[1878965523] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:642; }","duration":"2.462644371s","start":"2026-05-20T11:59:32.051817Z","end":"2026-05-20T11:59:34.514462Z","steps":["trace[1878965523] 'agreement among raft nodes before linearized reading' (duration: 2.462540629s)"],"step_count":1} {"level":"info","ts":"2026-05-20T11:59:34.514319Z","caller":"traceutil/trace.go:171","msg":"trace[6541753] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:642; }","duration":"2.462439108s","start":"2026-05-20T11:59:32.051866Z","end":"2026-05-20T11:59:34.514305Z","steps":["trace[6541753] 'agreement among raft nodes before linearized reading' (duration: 2.462200724s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:34.514509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:32.05174Z","time spent":"2.462760973s","remote":"127.0.0.1:33692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-20T11:59:34.514542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:32.05186Z","time spent":"2.462672211s","remote":"127.0.0.1:33692","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-20T11:59:34.514439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.768218054s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T11:59:34.514642Z","caller":"traceutil/trace.go:171","msg":"trace[1828453789] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"1.768469369s","start":"2026-05-20T11:59:32.746161Z","end":"2026-05-20T11:59:34.514631Z","steps":["trace[1828453789] 'agreement among raft nodes before linearized reading' (duration: 1.768251245s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:34.514682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:32.746134Z","time spent":"1.768538339s","remote":"127.0.0.1:33412","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-20T11:59:39.900982Z","caller":"traceutil/trace.go:171","msg":"trace[1326895136] linearizableReadLoop","detail":"{readStateIndex:741; appliedIndex:740; }","duration":"155.077763ms","start":"2026-05-20T11:59:39.745869Z","end":"2026-05-20T11:59:39.900946Z","steps":["trace[1326895136] 'read index received' (duration: 154.946271ms)","trace[1326895136] 'applied index is now lower than readState.Index' (duration: 130.172µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T11:59:39.901181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.301627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T11:59:39.901228Z","caller":"traceutil/trace.go:171","msg":"trace[1976752006] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:721; }","duration":"155.4376ms","start":"2026-05-20T11:59:39.745779Z","end":"2026-05-20T11:59:39.901216Z","steps":["trace[1976752006] 'agreement among raft nodes before linearized reading' (duration: 155.311518ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T11:59:39.901467Z","caller":"traceutil/trace.go:171","msg":"trace[1994058951] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"227.297999ms","start":"2026-05-20T11:59:39.674156Z","end":"2026-05-20T11:59:39.901454Z","steps":["trace[1994058951] 'process raft request' (duration: 226.596698ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T11:59:44.760888Z","caller":"traceutil/trace.go:171","msg":"trace[349183943] linearizableReadLoop","detail":"{readStateIndex:778; appliedIndex:775; }","duration":"148.206781ms","start":"2026-05-20T11:59:44.612647Z","end":"2026-05-20T11:59:44.760854Z","steps":["trace[349183943] 'read index received' (duration: 59.44302ms)","trace[349183943] 'applied index is now lower than readState.Index' (duration: 88.762441ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T11:59:44.760962Z","caller":"traceutil/trace.go:171","msg":"trace[1801356701] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"159.05402ms","start":"2026-05-20T11:59:44.601873Z","end":"2026-05-20T11:59:44.760927Z","steps":["trace[1801356701] 'process raft request' (duration: 115.883222ms)","trace[1801356701] 'compare' (duration: 42.971215ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T11:59:44.761529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.829301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-wxfkr\" ","response":"range_response_count:1 size:18709"} {"level":"info","ts":"2026-05-20T11:59:44.761672Z","caller":"traceutil/trace.go:171","msg":"trace[1392925950] range","detail":"{range_begin:/registry/pods/kube-system/cilium-wxfkr; range_end:; response_count:1; response_revision:756; }","duration":"148.997003ms","start":"2026-05-20T11:59:44.612643Z","end":"2026-05-20T11:59:44.76164Z","steps":["trace[1392925950] 'agreement among raft nodes before linearized reading' (duration: 148.333343ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T11:59:46.733415Z","caller":"traceutil/trace.go:171","msg":"trace[1915307407] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"105.99419ms","start":"2026-05-20T11:59:46.627368Z","end":"2026-05-20T11:59:46.733363Z","steps":["trace[1915307407] 'process raft request' (duration: 43.845731ms)","trace[1915307407] 'compare' (duration: 61.957436ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T11:59:46.848171Z","caller":"traceutil/trace.go:171","msg":"trace[1526781189] linearizableReadLoop","detail":"{readStateIndex:799; appliedIndex:796; }","duration":"103.366862ms","start":"2026-05-20T11:59:46.744782Z","end":"2026-05-20T11:59:46.848148Z","steps":["trace[1526781189] 'read index received' (duration: 22.640711ms)","trace[1526781189] 'applied index is now lower than readState.Index' (duration: 80.725111ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T11:59:46.848262Z","caller":"traceutil/trace.go:171","msg":"trace[343949653] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"108.849141ms","start":"2026-05-20T11:59:46.739347Z","end":"2026-05-20T11:59:46.848196Z","steps":["trace[343949653] 'process raft request' (duration: 99.330293ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:46.848368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.566814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T11:59:46.848407Z","caller":"traceutil/trace.go:171","msg":"trace[1644729530] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:777; }","duration":"103.651087ms","start":"2026-05-20T11:59:46.744744Z","end":"2026-05-20T11:59:46.848396Z","steps":["trace[1644729530] 'agreement among raft nodes before linearized reading' (duration: 103.571145ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T11:59:46.848404Z","caller":"traceutil/trace.go:171","msg":"trace[1850367476] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"107.879027ms","start":"2026-05-20T11:59:46.740463Z","end":"2026-05-20T11:59:46.848342Z","steps":["trace[1850367476] 'process raft request' (duration: 107.634334ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T11:59:48.597231Z","caller":"traceutil/trace.go:171","msg":"trace[647776928] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"342.176558ms","start":"2026-05-20T11:59:48.255025Z","end":"2026-05-20T11:59:48.597201Z","steps":["trace[647776928] 'process raft request' (duration: 342.027916ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:48.597411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:48.255005Z","time spent":"342.31242ms","remote":"127.0.0.1:33692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T11:59:51.246357Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151188528467648,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-20T11:59:51.507643Z","caller":"traceutil/trace.go:171","msg":"trace[218290829] linearizableReadLoop","detail":"{readStateIndex:832; appliedIndex:831; }","duration":"761.984101ms","start":"2026-05-20T11:59:50.745622Z","end":"2026-05-20T11:59:51.507606Z","steps":["trace[218290829] 'read index received' (duration: 757.214753ms)","trace[218290829] 'applied index is now lower than readState.Index' (duration: 4.767978ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T11:59:51.507708Z","caller":"traceutil/trace.go:171","msg":"trace[804491166] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"849.414386ms","start":"2026-05-20T11:59:50.658258Z","end":"2026-05-20T11:59:51.507673Z","steps":["trace[804491166] 'process raft request' (duration: 844.651128ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:51.508471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.894502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-20T11:59:51.508535Z","caller":"traceutil/trace.go:171","msg":"trace[1554783904] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:808; }","duration":"728.027524ms","start":"2026-05-20T11:59:50.78049Z","end":"2026-05-20T11:59:51.508518Z","steps":["trace[1554783904] 'agreement among raft nodes before linearized reading' (duration: 727.825791ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:51.508518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:50.658238Z","time spent":"850.176237ms","remote":"127.0.0.1:33692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T11:59:51.508584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:50.780463Z","time spent":"728.106505ms","remote":"127.0.0.1:33692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-20T11:59:51.508599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.054153ms","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-20T11:59:51.50863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.537764ms","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-20T11:59:51.507849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.199744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T11:59:51.50871Z","caller":"traceutil/trace.go:171","msg":"trace[1717827390] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:808; }","duration":"763.121258ms","start":"2026-05-20T11:59:50.74558Z","end":"2026-05-20T11:59:51.508701Z","steps":["trace[1717827390] 'agreement among raft nodes before linearized reading' (duration: 762.202045ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:51.50874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:50.745556Z","time spent":"763.175188ms","remote":"127.0.0.1:33428","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-20T11:59:51.508736Z","caller":"traceutil/trace.go:171","msg":"trace[51986608] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:808; }","duration":"646.648307ms","start":"2026-05-20T11:59:50.862049Z","end":"2026-05-20T11:59:51.508697Z","steps":["trace[51986608] 'agreement among raft nodes before linearized reading' (duration: 646.405673ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T11:59:51.508688Z","caller":"traceutil/trace.go:171","msg":"trace[1323292584] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:808; }","duration":"636.204606ms","start":"2026-05-20T11:59:50.872473Z","end":"2026-05-20T11:59:51.508677Z","steps":["trace[1323292584] 'agreement among raft nodes before linearized reading' (duration: 635.968193ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T11:59:51.508782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:50.862033Z","time spent":"646.739238ms","remote":"127.0.0.1:33692","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-20T11:59:51.508825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T11:59:50.872468Z","time spent":"636.346088ms","remote":"127.0.0.1:33692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-20T12:00:30.94059Z","caller":"traceutil/trace.go:171","msg":"trace[1025502802] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"118.133365ms","start":"2026-05-20T12:00:30.822425Z","end":"2026-05-20T12:00:30.940558Z","steps":["trace[1025502802] 'process raft request' (duration: 117.766141ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T12:00:34.113662Z","caller":"traceutil/trace.go:171","msg":"trace[1610897586] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"130.239687ms","start":"2026-05-20T12:00:33.983371Z","end":"2026-05-20T12:00:34.113611Z","steps":["trace[1610897586] 'process raft request' (duration: 103.703194ms)","trace[1610897586] 'compare' (duration: 26.402492ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T12:00:57.04761Z","caller":"traceutil/trace.go:171","msg":"trace[722189512] transaction","detail":"{read_only:false; response_revision:1154; number_of_response:1; }","duration":"104.788399ms","start":"2026-05-20T12:00:56.942792Z","end":"2026-05-20T12:00:57.047581Z","steps":["trace[722189512] 'process raft request' (duration: 99.901272ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T12:00:57.324548Z","caller":"traceutil/trace.go:171","msg":"trace[54218627] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"117.653424ms","start":"2026-05-20T12:00:57.206861Z","end":"2026-05-20T12:00:57.324514Z","steps":["trace[54218627] 'process raft request' (duration: 117.437102ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T12:01:57.074942Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151188528469309,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-20T12:01:57.097293Z","caller":"traceutil/trace.go:171","msg":"trace[1770904324] linearizableReadLoop","detail":"{readStateIndex:1446; appliedIndex:1445; }","duration":"523.454476ms","start":"2026-05-20T12:01:56.573808Z","end":"2026-05-20T12:01:57.097263Z","steps":["trace[1770904324] 'read index received' (duration: 523.227954ms)","trace[1770904324] 'applied index is now lower than readState.Index' (duration: 225.512µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T12:01:57.097409Z","caller":"traceutil/trace.go:171","msg":"trace[1008340921] transaction","detail":"{read_only:false; response_revision:1392; number_of_response:1; }","duration":"545.413709ms","start":"2026-05-20T12:01:56.551932Z","end":"2026-05-20T12:01:57.097345Z","steps":["trace[1008340921] 'process raft request' (duration: 545.167957ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T12:01:57.097512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.977798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T12:01:57.097558Z","caller":"traceutil/trace.go:171","msg":"trace[1500034800] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1392; }","duration":"483.109099ms","start":"2026-05-20T12:01:56.614434Z","end":"2026-05-20T12:01:57.097543Z","steps":["trace[1500034800] 'agreement among raft nodes before linearized reading' (duration: 483.001208ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T12:01:57.097588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T12:01:56.614402Z","time spent":"483.17969ms","remote":"127.0.0.1:33412","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-20T12:01:57.097571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.733939ms","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-20T12:01:57.097595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T12:01:56.551904Z","time spent":"545.593741ms","remote":"127.0.0.1:33692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T12:01:57.097656Z","caller":"traceutil/trace.go:171","msg":"trace[909458528] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1392; }","duration":"523.909801ms","start":"2026-05-20T12:01:56.573722Z","end":"2026-05-20T12:01:57.097632Z","steps":["trace[909458528] 'agreement among raft nodes before linearized reading' (duration: 523.656059ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T12:01:57.097697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T12:01:56.573657Z","time spent":"524.031752ms","remote":"127.0.0.1:33692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-20T12:01:57.097652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.616206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T12:01:57.097696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.528762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:ttl-controller\" ","response":"range_response_count:1 size:663"} {"level":"info","ts":"2026-05-20T12:01:57.097774Z","caller":"traceutil/trace.go:171","msg":"trace[1783201765] range","detail":"{range_begin:/registry/clusterroles/system:controller:ttl-controller; range_end:; response_count:1; response_revision:1392; }","duration":"431.648253ms","start":"2026-05-20T12:01:56.666107Z","end":"2026-05-20T12:01:57.097756Z","steps":["trace[1783201765] 'agreement among raft nodes before linearized reading' (duration: 431.472602ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T12:01:57.097782Z","caller":"traceutil/trace.go:171","msg":"trace[554505048] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1392; }","duration":"352.790057ms","start":"2026-05-20T12:01:56.744956Z","end":"2026-05-20T12:01:57.097746Z","steps":["trace[554505048] 'agreement among raft nodes before linearized reading' (duration: 352.601305ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T12:01:57.097851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.979919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:job-controller\" ","response":"range_response_count:1 size:731"} {"level":"warn","ts":"2026-05-20T12:01:57.097856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T12:01:56.744931Z","time spent":"352.909638ms","remote":"127.0.0.1:33428","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-20T12:01:57.097877Z","caller":"traceutil/trace.go:171","msg":"trace[829147727] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:job-controller; range_end:; response_count:1; response_revision:1392; }","duration":"420.01435ms","start":"2026-05-20T12:01:56.677853Z","end":"2026-05-20T12:01:57.097867Z","steps":["trace[829147727] 'agreement among raft nodes before linearized reading' (duration: 419.973789ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T12:01:57.097904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T12:01:56.677844Z","time spent":"420.05546ms","remote":"127.0.0.1:33768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":754,"request content":"key:\"/registry/clusterrolebindings/system:controller:job-controller\" "} {"level":"warn","ts":"2026-05-20T12:01:57.097905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.984118ms","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-20T12:01:57.097934Z","caller":"traceutil/trace.go:171","msg":"trace[1418510082] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1392; }","duration":"483.055088ms","start":"2026-05-20T12:01:56.61487Z","end":"2026-05-20T12:01:57.097925Z","steps":["trace[1418510082] 'agreement among raft nodes before linearized reading' (duration: 482.921817ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T12:01:57.097959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T12:01:56.614841Z","time spent":"483.108969ms","remote":"127.0.0.1:33692","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-20T12:01:57.097809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T12:01:56.666095Z","time spent":"431.707744ms","remote":"127.0.0.1:33766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":686,"request content":"key:\"/registry/clusterroles/system:controller:ttl-controller\" "}