{"level":"warn","ts":"2026-08-11T08:05:44.104072Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-11T08:05:44.104152Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.138: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.138:2380","--initial-cluster=instance=https://199.204.45.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.138: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-08-11T08:05:44.10422Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-11T08:05:44.104236Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-08-11T08:05:44.104256Z","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-08-11T08:05:44.104943Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"]} {"level":"info","ts":"2026-08-11T08:05:44.105012Z","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.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.138: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-08-11T08:05:44.113859Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.682852ms"} {"level":"info","ts":"2026-08-11T08:05:44.134415Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3d52791b64f7591","cluster-id":"90076b89649fe294"} {"level":"info","ts":"2026-08-11T08:05:44.134549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=()"} {"level":"info","ts":"2026-08-11T08:05:44.134572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 0"} {"level":"info","ts":"2026-08-11T08:05:44.134586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3d52791b64f7591 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-11T08:05:44.134595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 1"} {"level":"info","ts":"2026-08-11T08:05:44.134639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"warn","ts":"2026-08-11T08:05:44.143604Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-11T08:05:44.145218Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-11T08:05:44.147644Z","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-08-11T08:05:44.149948Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3d52791b64f7591","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-11T08:05:44.150129Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3d52791b64f7591","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-11T08:05:44.15026Z","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-08-11T08:05:44.150362Z","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-08-11T08:05:44.150371Z","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-08-11T08:05:44.158643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"info","ts":"2026-08-11T08:05:44.158842Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","added-peer-id":"f3d52791b64f7591","added-peer-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-08-11T08:05:44.159367Z","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-08-11T08:05:44.159422Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-08-11T08:05:44.159471Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-08-11T08:05:44.159621Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3d52791b64f7591","initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-11T08:05:44.159691Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-11T08:05:44.635013Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 is starting a new election at term 1"} {"level":"info","ts":"2026-08-11T08:05:44.635083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-11T08:05:44.635129Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgPreVoteResp from f3d52791b64f7591 at term 1"} {"level":"info","ts":"2026-08-11T08:05:44.635149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became candidate at term 2"} {"level":"info","ts":"2026-08-11T08:05:44.63516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgVoteResp from f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-08-11T08:05:44.635176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became leader at term 2"} {"level":"info","ts":"2026-08-11T08:05:44.635197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3d52791b64f7591 elected leader f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-08-11T08:05:44.643687Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:05:44.656094Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T08:05:44.656129Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3d52791b64f7591","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.138:2379]}","request-path":"/0/members/f3d52791b64f7591/attributes","cluster-id":"90076b89649fe294","publish-timeout":"7s"} {"level":"info","ts":"2026-08-11T08:05:44.656161Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T08:05:44.65644Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-11T08:05:44.656562Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-11T08:05:44.657688Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.138:2379"} {"level":"info","ts":"2026-08-11T08:05:44.660082Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-11T08:05:44.662442Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:05:44.662554Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:05:44.662587Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:05:46.281345Z","caller":"traceutil/trace.go:171","msg":"trace[1315497820] transaction","detail":"{read_only:false; response_revision:40; number_of_response:1; }","duration":"154.703091ms","start":"2026-08-11T08:05:46.126602Z","end":"2026-08-11T08:05:46.281305Z","steps":["trace[1315497820] 'process raft request' (duration: 67.763934ms)","trace[1315497820] 'compare' (duration: 86.725737ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:05:46.281522Z","caller":"traceutil/trace.go:171","msg":"trace[227722639] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"138.419174ms","start":"2026-08-11T08:05:46.143058Z","end":"2026-08-11T08:05:46.281477Z","steps":["trace[227722639] 'process raft request' (duration: 138.145311ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:05:46.281636Z","caller":"traceutil/trace.go:171","msg":"trace[1555202954] transaction","detail":"{read_only:false; response_revision:42; number_of_response:1; }","duration":"137.154078ms","start":"2026-08-11T08:05:46.144472Z","end":"2026-08-11T08:05:46.281626Z","steps":["trace[1555202954] 'process raft request' (duration: 136.773501ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:06:07.093155Z","caller":"traceutil/trace.go:171","msg":"trace[1180220570] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"295.498464ms","start":"2026-08-11T08:06:06.797638Z","end":"2026-08-11T08:06:07.093137Z","steps":["trace[1180220570] 'process raft request' (duration: 295.389419ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:06:07.094346Z","caller":"traceutil/trace.go:171","msg":"trace[1556537514] linearizableReadLoop","detail":"{readStateIndex:441; appliedIndex:440; }","duration":"194.395552ms","start":"2026-08-11T08:06:06.899935Z","end":"2026-08-11T08:06:07.094331Z","steps":["trace[1556537514] 'read index received' (duration: 193.31464ms)","trace[1556537514] 'applied index is now lower than readState.Index' (duration: 1.079782ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:06:07.094531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.527909ms","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-08-11T08:06:07.094654Z","caller":"traceutil/trace.go:171","msg":"trace[254359777] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:428; }","duration":"194.766011ms","start":"2026-08-11T08:06:06.899876Z","end":"2026-08-11T08:06:07.094642Z","steps":["trace[254359777] 'agreement among raft nodes before linearized reading' (duration: 194.522769ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:06:07.094752Z","caller":"traceutil/trace.go:171","msg":"trace[1631387690] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"286.831153ms","start":"2026-08-11T08:06:06.807864Z","end":"2026-08-11T08:06:07.094695Z","steps":["trace[1631387690] 'process raft request' (duration: 286.400322ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:10.345054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.587661ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T08:06:10.345215Z","caller":"traceutil/trace.go:171","msg":"trace[2065386256] linearizableReadLoop","detail":"{readStateIndex:482; appliedIndex:481; }","duration":"157.441061ms","start":"2026-08-11T08:06:10.187744Z","end":"2026-08-11T08:06:10.345185Z","steps":["trace[2065386256] 'read index received' (duration: 49.930794ms)","trace[2065386256] 'applied index is now lower than readState.Index' (duration: 107.508817ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:06:10.345291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.548775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:06:10.345264Z","caller":"traceutil/trace.go:171","msg":"trace[377188590] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"201.191207ms","start":"2026-08-11T08:06:10.144024Z","end":"2026-08-11T08:06:10.345215Z","steps":["trace[377188590] 'process raft request' (duration: 93.603977ms)","trace[377188590] 'compare' (duration: 106.400942ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:06:10.345331Z","caller":"traceutil/trace.go:171","msg":"trace[610071717] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:466; }","duration":"157.64882ms","start":"2026-08-11T08:06:10.187672Z","end":"2026-08-11T08:06:10.345321Z","steps":["trace[610071717] 'agreement among raft nodes before linearized reading' (duration: 157.582977ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:06:10.526063Z","caller":"traceutil/trace.go:171","msg":"trace[1105486206] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"130.650273ms","start":"2026-08-11T08:06:10.395383Z","end":"2026-08-11T08:06:10.526034Z","steps":["trace[1105486206] 'process raft request' (duration: 96.647749ms)","trace[1105486206] 'compare' (duration: 33.855487ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:06:16.750386Z","caller":"traceutil/trace.go:171","msg":"trace[675634594] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"182.533822ms","start":"2026-08-11T08:06:16.567835Z","end":"2026-08-11T08:06:16.750368Z","steps":["trace[675634594] 'process raft request' (duration: 182.414026ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:06:22.533423Z","caller":"traceutil/trace.go:171","msg":"trace[1707240043] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"188.401935ms","start":"2026-08-11T08:06:22.344993Z","end":"2026-08-11T08:06:22.533394Z","steps":["trace[1707240043] 'process raft request' (duration: 188.267868ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:06:22.546256Z","caller":"traceutil/trace.go:171","msg":"trace[1719007834] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"197.382481ms","start":"2026-08-11T08:06:22.34885Z","end":"2026-08-11T08:06:22.546233Z","steps":["trace[1719007834] 'process raft request' (duration: 196.99679ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:06:22.54632Z","caller":"traceutil/trace.go:171","msg":"trace[318990733] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"184.316124ms","start":"2026-08-11T08:06:22.361999Z","end":"2026-08-11T08:06:22.546315Z","steps":["trace[318990733] 'process raft request' (duration: 183.954965ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:06:22.546379Z","caller":"traceutil/trace.go:171","msg":"trace[345397020] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"197.598222ms","start":"2026-08-11T08:06:22.348772Z","end":"2026-08-11T08:06:22.54637Z","steps":["trace[345397020] 'process raft request' (duration: 197.015141ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:06:22.546439Z","caller":"traceutil/trace.go:171","msg":"trace[702857378] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"179.838222ms","start":"2026-08-11T08:06:22.366591Z","end":"2026-08-11T08:06:22.54643Z","steps":["trace[702857378] 'process raft request' (duration: 179.378949ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:06:22.546292Z","caller":"traceutil/trace.go:171","msg":"trace[278773320] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"161.635599ms","start":"2026-08-11T08:06:22.384642Z","end":"2026-08-11T08:06:22.546278Z","steps":["trace[278773320] 'process raft request' (duration: 161.351704ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:06:22.546499Z","caller":"traceutil/trace.go:171","msg":"trace[53178876] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"186.207513ms","start":"2026-08-11T08:06:22.360285Z","end":"2026-08-11T08:06:22.546493Z","steps":["trace[53178876] 'process raft request' (duration: 185.603611ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:06:22.546531Z","caller":"traceutil/trace.go:171","msg":"trace[1397725764] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"131.452054ms","start":"2026-08-11T08:06:22.415068Z","end":"2026-08-11T08:06:22.54652Z","steps":["trace[1397725764] 'process raft request' (duration: 130.98882ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:06:22.54654Z","caller":"traceutil/trace.go:171","msg":"trace[1198585881] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"155.696511ms","start":"2026-08-11T08:06:22.39084Z","end":"2026-08-11T08:06:22.546536Z","steps":["trace[1198585881] 'process raft request' (duration: 155.184945ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:06:22.546552Z","caller":"traceutil/trace.go:171","msg":"trace[1359175754] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"189.745615ms","start":"2026-08-11T08:06:22.356723Z","end":"2026-08-11T08:06:22.546469Z","steps":["trace[1359175754] 'process raft request' (duration: 189.142493ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:06:22.54622Z","caller":"traceutil/trace.go:171","msg":"trace[606578329] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"184.638691ms","start":"2026-08-11T08:06:22.361555Z","end":"2026-08-11T08:06:22.546193Z","steps":["trace[606578329] 'process raft request' (duration: 184.353716ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:23.277182Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471728226583202469,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-11T08:06:23.641508Z","caller":"traceutil/trace.go:171","msg":"trace[1551359745] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"988.113217ms","start":"2026-08-11T08:06:22.653372Z","end":"2026-08-11T08:06:23.641485Z","steps":["trace[1551359745] 'process raft request' (duration: 973.864675ms)","trace[1551359745] 'compare' (duration: 13.981398ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:06:23.641629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:22.653355Z","time spent":"988.209152ms","remote":"127.0.0.1:41284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:06:23.642417Z","caller":"traceutil/trace.go:171","msg":"trace[1579976168] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"982.408443ms","start":"2026-08-11T08:06:22.659992Z","end":"2026-08-11T08:06:23.6424Z","steps":["trace[1579976168] 'process raft request' (duration: 982.208672ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:23.642556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:22.659958Z","time spent":"982.510258ms","remote":"127.0.0.1:41284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:06:23.642727Z","caller":"traceutil/trace.go:171","msg":"trace[30496934] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"978.279178ms","start":"2026-08-11T08:06:22.664417Z","end":"2026-08-11T08:06:23.642696Z","steps":["trace[30496934] 'process raft request' (duration: 977.951871ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:23.642938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:22.664397Z","time spent":"978.434946ms","remote":"127.0.0.1:41284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10855,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:06:23.64297Z","caller":"traceutil/trace.go:171","msg":"trace[1202811967] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"977.775482ms","start":"2026-08-11T08:06:22.665179Z","end":"2026-08-11T08:06:23.642955Z","steps":["trace[1202811967] 'process raft request' (duration: 977.419714ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:23.643061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:22.665164Z","time spent":"977.840006ms","remote":"127.0.0.1:41284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T08:06:23.643128Z","caller":"traceutil/trace.go:171","msg":"trace[399992622] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"945.315429ms","start":"2026-08-11T08:06:22.697794Z","end":"2026-08-11T08:06:23.64311Z","steps":["trace[399992622] 'process raft request' (duration: 944.905848ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:23.643225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:22.697774Z","time spent":"945.400024ms","remote":"127.0.0.1:41284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:06:23.656068Z","caller":"traceutil/trace.go:171","msg":"trace[2017063827] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:573; }","duration":"879.443428ms","start":"2026-08-11T08:06:22.776606Z","end":"2026-08-11T08:06:23.656049Z","steps":["trace[2017063827] 'read index received' (duration: 850.708482ms)","trace[2017063827] 'applied index is now lower than readState.Index' (duration: 28.733985ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:06:23.656264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"879.650049ms","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-08-11T08:06:23.656286Z","caller":"traceutil/trace.go:171","msg":"trace[1067372970] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:559; }","duration":"879.736853ms","start":"2026-08-11T08:06:22.776544Z","end":"2026-08-11T08:06:23.656281Z","steps":["trace[1067372970] 'agreement among raft nodes before linearized reading' (duration: 879.619516ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:23.656306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:22.776521Z","time spent":"879.780995ms","remote":"127.0.0.1:41486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-11T08:06:23.664895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.155404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:06:23.66505Z","caller":"traceutil/trace.go:171","msg":"trace[1724055593] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:560; }","duration":"477.355885ms","start":"2026-08-11T08:06:23.187679Z","end":"2026-08-11T08:06:23.665035Z","steps":["trace[1724055593] 'agreement among raft nodes before linearized reading' (duration: 477.149644ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:23.665135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:23.187659Z","time spent":"477.46157ms","remote":"127.0.0.1:41242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-11T08:06:23.665404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.301816ms","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-08-11T08:06:23.665477Z","caller":"traceutil/trace.go:171","msg":"trace[584406585] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:560; }","duration":"359.410141ms","start":"2026-08-11T08:06:23.306059Z","end":"2026-08-11T08:06:23.665469Z","steps":["trace[584406585] 'agreement among raft nodes before linearized reading' (duration: 359.281135ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:23.665552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:23.306039Z","time spent":"359.506266ms","remote":"127.0.0.1:41486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-11T08:06:30.476284Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471728226583202638,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-11T08:06:30.56622Z","caller":"traceutil/trace.go:171","msg":"trace[440960120] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"637.201466ms","start":"2026-08-11T08:06:29.928989Z","end":"2026-08-11T08:06:30.56619Z","steps":["trace[440960120] 'process raft request' (duration: 637.001646ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:30.566366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:29.928977Z","time spent":"637.316723ms","remote":"127.0.0.1:41408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:06:31.970003Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.100569476s","expected-duration":"1s"} {"level":"info","ts":"2026-08-11T08:06:31.971254Z","caller":"traceutil/trace.go:171","msg":"trace[348947469] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:658; }","duration":"1.995500227s","start":"2026-08-11T08:06:29.975693Z","end":"2026-08-11T08:06:31.971193Z","steps":["trace[348947469] 'read index received' (duration: 590.397997ms)","trace[348947469] 'applied index is now lower than readState.Index' (duration: 1.405101119s)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:06:31.971435Z","caller":"traceutil/trace.go:171","msg":"trace[1027392332] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"1.873000413s","start":"2026-08-11T08:06:30.09842Z","end":"2026-08-11T08:06:31.97142Z","steps":["trace[1027392332] 'process raft request' (duration: 1.872121246s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:31.971613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:30.098392Z","time spent":"1.873077696s","remote":"127.0.0.1:41308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:06:31.972046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.996347251s","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-08-11T08:06:31.972115Z","caller":"traceutil/trace.go:171","msg":"trace[641194257] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:639; }","duration":"1.996451756s","start":"2026-08-11T08:06:29.975645Z","end":"2026-08-11T08:06:31.972097Z","steps":["trace[641194257] 'agreement among raft nodes before linearized reading' (duration: 1.996220534s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:31.972161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:29.975626Z","time spent":"1.99652269s","remote":"127.0.0.1:41486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-11T08:06:31.977799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.329723615s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-11T08:06:31.977838Z","caller":"traceutil/trace.go:171","msg":"trace[1227636583] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"1.244271335s","start":"2026-08-11T08:06:30.733526Z","end":"2026-08-11T08:06:31.977798Z","steps":["trace[1227636583] 'process raft request' (duration: 1.244057183s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:31.977868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.940956ms","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-08-11T08:06:31.97792Z","caller":"traceutil/trace.go:171","msg":"trace[432278097] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:640; }","duration":"228.01866ms","start":"2026-08-11T08:06:31.749888Z","end":"2026-08-11T08:06:31.977906Z","steps":["trace[432278097] 'agreement among raft nodes before linearized reading' (duration: 227.868382ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:31.977983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.793367ms","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-08-11T08:06:31.977997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:30.733495Z","time spent":"1.244413381s","remote":"127.0.0.1:41486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:06:31.978024Z","caller":"traceutil/trace.go:171","msg":"trace[1567015252] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:640; }","duration":"263.874801ms","start":"2026-08-11T08:06:31.714137Z","end":"2026-08-11T08:06:31.978012Z","steps":["trace[1567015252] 'agreement among raft nodes before linearized reading' (duration: 263.761235ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:06:31.977871Z","caller":"traceutil/trace.go:171","msg":"trace[1685339276] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:640; }","duration":"1.329833511s","start":"2026-08-11T08:06:30.64802Z","end":"2026-08-11T08:06:31.977854Z","steps":["trace[1685339276] 'agreement among raft nodes before linearized reading' (duration: 1.329657481s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:31.978144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"789.744344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T08:06:31.978154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:30.647994Z","time spent":"1.330106125s","remote":"127.0.0.1:41486","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":"info","ts":"2026-08-11T08:06:31.978182Z","caller":"traceutil/trace.go:171","msg":"trace[1263564175] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:640; }","duration":"789.841879ms","start":"2026-08-11T08:06:31.188329Z","end":"2026-08-11T08:06:31.978171Z","steps":["trace[1263564175] 'agreement among raft nodes before linearized reading' (duration: 789.785496ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:31.978344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:31.188308Z","time spent":"790.027059ms","remote":"127.0.0.1:41242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-11T08:06:32.114281Z","caller":"traceutil/trace.go:171","msg":"trace[872726508] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"132.869856ms","start":"2026-08-11T08:06:31.981355Z","end":"2026-08-11T08:06:32.114225Z","steps":["trace[872726508] 'read index received' (duration: 132.681516ms)","trace[872726508] 'applied index is now lower than readState.Index' (duration: 187.12µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:06:32.114336Z","caller":"traceutil/trace.go:171","msg":"trace[1274169820] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"138.427353ms","start":"2026-08-11T08:06:31.975866Z","end":"2026-08-11T08:06:32.114294Z","steps":["trace[1274169820] 'process raft request' (duration: 138.204241ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:32.114407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.028554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:06:32.114441Z","caller":"traceutil/trace.go:171","msg":"trace[1369606235] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"133.091108ms","start":"2026-08-11T08:06:31.981339Z","end":"2026-08-11T08:06:32.11443Z","steps":["trace[1369606235] 'agreement among raft nodes before linearized reading' (duration: 133.018974ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:33.921112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"845.502066ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T08:06:33.921386Z","caller":"traceutil/trace.go:171","msg":"trace[1954555097] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"1.938937963s","start":"2026-08-11T08:06:31.982416Z","end":"2026-08-11T08:06:33.921354Z","steps":["trace[1954555097] 'process raft request' (duration: 1.09310664s)","trace[1954555097] 'compare' (duration: 845.366138ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:06:33.921409Z","caller":"traceutil/trace.go:171","msg":"trace[1654450158] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"1.938665108s","start":"2026-08-11T08:06:31.9827Z","end":"2026-08-11T08:06:33.921365Z","steps":["trace[1654450158] 'process raft request' (duration: 1.93851392s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:33.921516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:31.982406Z","time spent":"1.939030268s","remote":"127.0.0.1:41486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:06:33.921544Z","caller":"traceutil/trace.go:171","msg":"trace[1528447280] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"1.938552802s","start":"2026-08-11T08:06:31.982956Z","end":"2026-08-11T08:06:33.921509Z","steps":["trace[1528447280] 'process raft request' (duration: 1.93832403s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:33.921569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:31.982685Z","time spent":"1.938809316s","remote":"127.0.0.1:41486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:06:33.921662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:31.982949Z","time spent":"1.938655508s","remote":"127.0.0.1:41486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:06:33.921828Z","caller":"traceutil/trace.go:171","msg":"trace[1900108848] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"1.899672738s","start":"2026-08-11T08:06:32.022132Z","end":"2026-08-11T08:06:33.921805Z","steps":["trace[1900108848] 'process raft request' (duration: 1.899196292s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:33.92209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:32.022108Z","time spent":"1.899926322s","remote":"127.0.0.1:41458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T08:06:33.921827Z","caller":"traceutil/trace.go:171","msg":"trace[430764503] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:662; }","duration":"733.712875ms","start":"2026-08-11T08:06:33.188088Z","end":"2026-08-11T08:06:33.921801Z","steps":["trace[430764503] 'read index received' (duration: 52.113µs)","trace[430764503] 'applied index is now lower than readState.Index' (duration: 733.657822ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:06:33.937623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.532483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:06:33.937687Z","caller":"traceutil/trace.go:171","msg":"trace[388642419] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"749.603277ms","start":"2026-08-11T08:06:33.188066Z","end":"2026-08-11T08:06:33.93767Z","steps":["trace[388642419] 'agreement among raft nodes before linearized reading' (duration: 733.832112ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:33.937732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:33.187996Z","time spent":"749.727744ms","remote":"127.0.0.1:41242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-11T08:06:36.359321Z","caller":"traceutil/trace.go:171","msg":"trace[1091011663] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"227.081335ms","start":"2026-08-11T08:06:36.132216Z","end":"2026-08-11T08:06:36.359297Z","steps":["trace[1091011663] 'process raft request' (duration: 226.948748ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:06:39.22201Z","caller":"traceutil/trace.go:171","msg":"trace[218793461] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"111.800465ms","start":"2026-08-11T08:06:39.110176Z","end":"2026-08-11T08:06:39.221977Z","steps":["trace[218793461] 'process raft request' (duration: 111.316628ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:06:46.457319Z","caller":"traceutil/trace.go:171","msg":"trace[1811505760] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"437.549126ms","start":"2026-08-11T08:06:46.019737Z","end":"2026-08-11T08:06:46.457286Z","steps":["trace[1811505760] 'process raft request' (duration: 383.508108ms)","trace[1811505760] 'compare' (duration: 53.752432ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:06:46.457481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:46.019708Z","time spent":"437.690713ms","remote":"127.0.0.1:41486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:06:50.923748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.471514ms","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-08-11T08:06:50.923836Z","caller":"traceutil/trace.go:171","msg":"trace[201607412] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:799; }","duration":"889.605052ms","start":"2026-08-11T08:06:50.034213Z","end":"2026-08-11T08:06:50.923818Z","steps":["trace[201607412] 'range keys from in-memory index tree' (duration: 889.317295ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:50.923874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:50.034194Z","time spent":"889.672215ms","remote":"127.0.0.1:41486","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-08-11T08:06:50.924378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.728244342s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:06:50.924474Z","caller":"traceutil/trace.go:171","msg":"trace[328788743] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:799; }","duration":"1.728415822s","start":"2026-08-11T08:06:49.196033Z","end":"2026-08-11T08:06:50.924449Z","steps":["trace[328788743] 'range keys from in-memory index tree' (duration: 1.728146977s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:50.924532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:49.196011Z","time spent":"1.728501907s","remote":"127.0.0.1:41240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-11T08:06:50.924024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"888.360193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-11T08:06:50.924614Z","caller":"traceutil/trace.go:171","msg":"trace[1736211741] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:799; }","duration":"889.079323ms","start":"2026-08-11T08:06:50.035517Z","end":"2026-08-11T08:06:50.924596Z","steps":["trace[1736211741] 'range keys from in-memory index tree' (duration: 888.212984ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:50.92466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:50.035509Z","time spent":"889.137656ms","remote":"127.0.0.1:41486","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-08-11T08:06:50.924662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"982.892085ms","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-08-11T08:06:50.924716Z","caller":"traceutil/trace.go:171","msg":"trace[1501360374] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:799; }","duration":"982.98018ms","start":"2026-08-11T08:06:49.94172Z","end":"2026-08-11T08:06:50.9247Z","steps":["trace[1501360374] 'range keys from in-memory index tree' (duration: 982.77587ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:50.924755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:49.941701Z","time spent":"983.045044ms","remote":"127.0.0.1:41486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-11T08:06:50.938277Z","caller":"traceutil/trace.go:171","msg":"trace[992277776] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"876.555445ms","start":"2026-08-11T08:06:50.061703Z","end":"2026-08-11T08:06:50.938259Z","steps":["trace[992277776] 'process raft request' (duration: 876.443178ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:06:50.938283Z","caller":"traceutil/trace.go:171","msg":"trace[2116787400] linearizableReadLoop","detail":"{readStateIndex:827; appliedIndex:827; }","duration":"464.208813ms","start":"2026-08-11T08:06:50.474057Z","end":"2026-08-11T08:06:50.938265Z","steps":["trace[2116787400] 'read index received' (duration: 464.201933ms)","trace[2116787400] 'applied index is now lower than readState.Index' (duration: 5.4µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:06:50.938399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:50.061666Z","time spent":"876.668382ms","remote":"127.0.0.1:41458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:06:50.93874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.68864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-11T08:06:50.9388Z","caller":"traceutil/trace.go:171","msg":"trace[1528277185] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:800; }","duration":"464.765945ms","start":"2026-08-11T08:06:50.474022Z","end":"2026-08-11T08:06:50.938788Z","steps":["trace[1528277185] 'agreement among raft nodes before linearized reading' (duration: 464.608355ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:50.938841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:50.474007Z","time spent":"464.827387ms","remote":"127.0.0.1:41486","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-08-11T08:06:50.95165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.282012ms","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-08-11T08:06:50.95169Z","caller":"traceutil/trace.go:171","msg":"trace[703962815] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:804; }","duration":"472.366058ms","start":"2026-08-11T08:06:50.479315Z","end":"2026-08-11T08:06:50.951681Z","steps":["trace[703962815] 'agreement among raft nodes before linearized reading' (duration: 472.21648ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:06:50.951717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:06:50.479304Z","time spent":"472.403851ms","remote":"127.0.0.1:41486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-11T08:07:35.42808Z","caller":"traceutil/trace.go:171","msg":"trace[1453639156] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"121.161071ms","start":"2026-08-11T08:07:35.306891Z","end":"2026-08-11T08:07:35.428052Z","steps":["trace[1453639156] 'process raft request' (duration: 106.223675ms)","trace[1453639156] 'compare' (duration: 14.799528ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:07:35.428212Z","caller":"traceutil/trace.go:171","msg":"trace[1715613887] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"120.62174ms","start":"2026-08-11T08:07:35.307558Z","end":"2026-08-11T08:07:35.428179Z","steps":["trace[1715613887] 'process raft request' (duration: 120.46555ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:07:41.606245Z","caller":"traceutil/trace.go:171","msg":"trace[1928965618] linearizableReadLoop","detail":"{readStateIndex:1144; appliedIndex:1143; }","duration":"185.870751ms","start":"2026-08-11T08:07:41.420343Z","end":"2026-08-11T08:07:41.606214Z","steps":["trace[1928965618] 'read index received' (duration: 171.7769ms)","trace[1928965618] 'applied index is now lower than readState.Index' (duration: 14.092561ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:07:41.606443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.078213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:07:41.606413Z","caller":"traceutil/trace.go:171","msg":"trace[550400771] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"200.062037ms","start":"2026-08-11T08:07:41.406316Z","end":"2026-08-11T08:07:41.606378Z","steps":["trace[550400771] 'process raft request' (duration: 185.820967ms)","trace[550400771] 'compare' (duration: 13.92096ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:07:41.606498Z","caller":"traceutil/trace.go:171","msg":"trace[190805872] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1104; }","duration":"186.180049ms","start":"2026-08-11T08:07:41.420303Z","end":"2026-08-11T08:07:41.606483Z","steps":["trace[190805872] 'agreement among raft nodes before linearized reading' (duration: 186.073293ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:07:41.606797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.792099ms","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-08-11T08:07:41.606836Z","caller":"traceutil/trace.go:171","msg":"trace[1220678579] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1104; }","duration":"174.847193ms","start":"2026-08-11T08:07:41.431979Z","end":"2026-08-11T08:07:41.606826Z","steps":["trace[1220678579] 'agreement among raft nodes before linearized reading' (duration: 174.709675ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:07:41.607033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.359028ms","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-08-11T08:07:41.607069Z","caller":"traceutil/trace.go:171","msg":"trace[199897561] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1104; }","duration":"161.411201ms","start":"2026-08-11T08:07:41.445649Z","end":"2026-08-11T08:07:41.60706Z","steps":["trace[199897561] 'agreement among raft nodes before linearized reading' (duration: 161.318275ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:07:41.607061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.93527ms","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-08-11T08:07:41.607119Z","caller":"traceutil/trace.go:171","msg":"trace[555895224] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1104; }","duration":"140.057766ms","start":"2026-08-11T08:07:41.467046Z","end":"2026-08-11T08:07:41.607104Z","steps":["trace[555895224] 'agreement among raft nodes before linearized reading' (duration: 139.854194ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:07:41.607568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.514264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-11T08:07:41.607615Z","caller":"traceutil/trace.go:171","msg":"trace[771098839] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1104; }","duration":"139.574648ms","start":"2026-08-11T08:07:41.468026Z","end":"2026-08-11T08:07:41.607601Z","steps":["trace[771098839] 'agreement among raft nodes before linearized reading' (duration: 138.805672ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:08:09.879756Z","caller":"traceutil/trace.go:171","msg":"trace[1505483089] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"112.350041ms","start":"2026-08-11T08:08:09.767381Z","end":"2026-08-11T08:08:09.879731Z","steps":["trace[1505483089] 'process raft request' (duration: 112.182191ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:08:40.532565Z","caller":"traceutil/trace.go:171","msg":"trace[117794656] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"452.731452ms","start":"2026-08-11T08:08:40.07981Z","end":"2026-08-11T08:08:40.532541Z","steps":["trace[117794656] 'process raft request' (duration: 452.56005ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:08:40.532727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:08:40.079794Z","time spent":"452.844889ms","remote":"127.0.0.1:41486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:08:40.538788Z","caller":"traceutil/trace.go:171","msg":"trace[1380633468] linearizableReadLoop","detail":"{readStateIndex:1387; appliedIndex:1385; }","duration":"405.12916ms","start":"2026-08-11T08:08:40.133637Z","end":"2026-08-11T08:08:40.538766Z","steps":["trace[1380633468] 'read index received' (duration: 398.723695ms)","trace[1380633468] 'applied index is now lower than readState.Index' (duration: 6.403985ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:08:40.538862Z","caller":"traceutil/trace.go:171","msg":"trace[1240038691] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"455.430508ms","start":"2026-08-11T08:08:40.0834Z","end":"2026-08-11T08:08:40.53883Z","steps":["trace[1240038691] 'process raft request' (duration: 455.207074ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:08:40.539027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.630054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T08:08:40.539058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.321348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-08-11T08:08:40.539079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.396867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-11T08:08:40.539086Z","caller":"traceutil/trace.go:171","msg":"trace[721503536] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1334; }","duration":"350.749991ms","start":"2026-08-11T08:08:40.188321Z","end":"2026-08-11T08:08:40.539071Z","steps":["trace[721503536] 'agreement among raft nodes before linearized reading' (duration: 350.642444ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:08:40.538894Z","caller":"traceutil/trace.go:171","msg":"trace[572628081] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"151.476499ms","start":"2026-08-11T08:08:40.387386Z","end":"2026-08-11T08:08:40.538863Z","steps":["trace[572628081] 'process raft request' (duration: 151.33489ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:08:40.539113Z","caller":"traceutil/trace.go:171","msg":"trace[1570543088] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1334; }","duration":"396.393762ms","start":"2026-08-11T08:08:40.142706Z","end":"2026-08-11T08:08:40.539099Z","steps":["trace[1570543088] 'agreement among raft nodes before linearized reading' (duration: 396.245563ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:08:40.539125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:08:40.1883Z","time spent":"350.816616ms","remote":"127.0.0.1:41242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-11T08:08:40.53912Z","caller":"traceutil/trace.go:171","msg":"trace[484734309] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1334; }","duration":"405.522975ms","start":"2026-08-11T08:08:40.133586Z","end":"2026-08-11T08:08:40.539109Z","steps":["trace[484734309] 'agreement among raft nodes before linearized reading' (duration: 405.298261ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:08:40.539154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:08:40.142695Z","time spent":"396.449156ms","remote":"127.0.0.1:41486","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-08-11T08:08:40.539186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:08:40.133573Z","time spent":"405.601839ms","remote":"127.0.0.1:41486","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-08-11T08:08:40.53935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.374253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-11T08:08:40.53939Z","caller":"traceutil/trace.go:171","msg":"trace[960227540] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1334; }","duration":"391.468819ms","start":"2026-08-11T08:08:40.147912Z","end":"2026-08-11T08:08:40.539381Z","steps":["trace[960227540] 'agreement among raft nodes before linearized reading' (duration: 391.111317ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:08:40.539412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:08:40.147885Z","time spent":"391.520772ms","remote":"127.0.0.1:41486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-11T08:08:40.539411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:08:40.083292Z","time spent":"455.637461ms","remote":"127.0.0.1:41486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:08:54.900537Z","caller":"traceutil/trace.go:171","msg":"trace[1219666504] linearizableReadLoop","detail":"{readStateIndex:1443; appliedIndex:1442; }","duration":"144.229568ms","start":"2026-08-11T08:08:54.756284Z","end":"2026-08-11T08:08:54.900514Z","steps":["trace[1219666504] 'read index received' (duration: 81.849571ms)","trace[1219666504] 'applied index is now lower than readState.Index' (duration: 62.379047ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:08:54.900628Z","caller":"traceutil/trace.go:171","msg":"trace[86986546] transaction","detail":"{read_only:false; response_revision:1386; number_of_response:1; }","duration":"147.014629ms","start":"2026-08-11T08:08:54.753574Z","end":"2026-08-11T08:08:54.900589Z","steps":["trace[86986546] 'process raft request' (duration: 84.706757ms)","trace[86986546] 'compare' (duration: 62.119371ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:08:54.900781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.477653ms","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-08-11T08:08:54.900815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.157601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:monitoring\" ","response":"range_response_count:1 size:694"} {"level":"warn","ts":"2026-08-11T08:08:54.900823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.928112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:node\" ","response":"range_response_count:1 size:603"} {"level":"info","ts":"2026-08-11T08:08:54.90091Z","caller":"traceutil/trace.go:171","msg":"trace[425047816] range","detail":"{range_begin:/registry/clusterrolebindings/system:node; range_end:; response_count:1; response_revision:1386; }","duration":"102.0607ms","start":"2026-08-11T08:08:54.798828Z","end":"2026-08-11T08:08:54.900888Z","steps":["trace[425047816] 'agreement among raft nodes before linearized reading' (duration: 101.918641ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:08:54.901123Z","caller":"traceutil/trace.go:171","msg":"trace[1702568691] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1386; }","duration":"144.855736ms","start":"2026-08-11T08:08:54.756254Z","end":"2026-08-11T08:08:54.901109Z","steps":["trace[1702568691] 'agreement among raft nodes before linearized reading' (duration: 144.400098ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:08:54.901435Z","caller":"traceutil/trace.go:171","msg":"trace[470221946] range","detail":"{range_begin:/registry/clusterrolebindings/system:monitoring; range_end:; response_count:1; response_revision:1386; }","duration":"126.277098ms","start":"2026-08-11T08:08:54.774627Z","end":"2026-08-11T08:08:54.900904Z","steps":["trace[470221946] 'agreement among raft nodes before linearized reading' (duration: 126.082616ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:08:59.12646Z","caller":"traceutil/trace.go:171","msg":"trace[1231950077] linearizableReadLoop","detail":"{readStateIndex:1458; appliedIndex:1457; }","duration":"192.686158ms","start":"2026-08-11T08:08:58.933749Z","end":"2026-08-11T08:08:59.126436Z","steps":["trace[1231950077] 'read index received' (duration: 192.481406ms)","trace[1231950077] 'applied index is now lower than readState.Index' (duration: 203.862µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:08:59.126545Z","caller":"traceutil/trace.go:171","msg":"trace[576693380] transaction","detail":"{read_only:false; response_revision:1400; number_of_response:1; }","duration":"210.257316ms","start":"2026-08-11T08:08:58.916263Z","end":"2026-08-11T08:08:59.126521Z","steps":["trace[576693380] 'process raft request' (duration: 210.031982ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:08:59.126669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.898531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:833"} {"level":"info","ts":"2026-08-11T08:08:59.126712Z","caller":"traceutil/trace.go:171","msg":"trace[1967259944] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:1400; }","duration":"192.983127ms","start":"2026-08-11T08:08:58.933718Z","end":"2026-08-11T08:08:59.126701Z","steps":["trace[1967259944] 'agreement among raft nodes before linearized reading' (duration: 192.832687ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:08:59.126754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.777431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/kube-node-lease/\" range_end:\"/registry/services/endpoints/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:08:59.126835Z","caller":"traceutil/trace.go:171","msg":"trace[1686289266] range","detail":"{range_begin:/registry/services/endpoints/kube-node-lease/; range_end:/registry/services/endpoints/kube-node-lease0; response_count:0; response_revision:1400; }","duration":"185.892428ms","start":"2026-08-11T08:08:58.940921Z","end":"2026-08-11T08:08:59.126814Z","steps":["trace[1686289266] 'agreement among raft nodes before linearized reading' (duration: 185.740198ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:08:59.126898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.255389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/default/\" range_end:\"/registry/secrets/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:08:59.126955Z","caller":"traceutil/trace.go:171","msg":"trace[2071043824] range","detail":"{range_begin:/registry/secrets/default/; range_end:/registry/secrets/default0; response_count:0; response_revision:1400; }","duration":"154.353985ms","start":"2026-08-11T08:08:58.972587Z","end":"2026-08-11T08:08:59.126941Z","steps":["trace[2071043824] 'agreement among raft nodes before linearized reading' (duration: 154.242509ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:08:59.126846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.493591ms","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-08-11T08:08:59.12697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.58947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy\" ","response":"range_response_count:1 size:4434"} {"level":"info","ts":"2026-08-11T08:08:59.127104Z","caller":"traceutil/trace.go:171","msg":"trace[2080670981] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy; range_end:; response_count:1; response_revision:1400; }","duration":"138.797792ms","start":"2026-08-11T08:08:58.98829Z","end":"2026-08-11T08:08:59.127088Z","steps":["trace[2080670981] 'agreement among raft nodes before linearized reading' (duration: 138.395868ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:08:59.12728Z","caller":"traceutil/trace.go:171","msg":"trace[950191851] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1400; }","duration":"126.727255ms","start":"2026-08-11T08:08:59.000316Z","end":"2026-08-11T08:08:59.127043Z","steps":["trace[950191851] 'agreement among raft nodes before linearized reading' (duration: 126.389064ms)"],"step_count":1}