{"level":"warn","ts":"2026-08-24T15:12:35.729917Z","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-24T15:12:35.73005Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.119:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.119:2380","--initial-cluster=instance=https://199.19.213.119:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.119:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.119: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-24T15:12:35.730119Z","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-24T15:12:35.730129Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.119:2380"]} {"level":"info","ts":"2026-08-24T15:12:35.730147Z","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-24T15:12:35.730815Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.119:2379"]} {"level":"info","ts":"2026-08-24T15:12:35.730906Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.119:2380"],"listen-peer-urls":["https://199.19.213.119:2380"],"advertise-client-urls":["https://199.19.213.119:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.119:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.119: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-24T15:12:35.734598Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.340427ms"} {"level":"info","ts":"2026-08-24T15:12:35.744143Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ec9077c81c499df2","cluster-id":"7e82d3f5f740d3fb"} {"level":"info","ts":"2026-08-24T15:12:35.744231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 switched to configuration voters=()"} {"level":"info","ts":"2026-08-24T15:12:35.744259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 became follower at term 0"} {"level":"info","ts":"2026-08-24T15:12:35.744271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ec9077c81c499df2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-24T15:12:35.74428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 became follower at term 1"} {"level":"info","ts":"2026-08-24T15:12:35.744348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 switched to configuration voters=(17046256290949078514)"} {"level":"warn","ts":"2026-08-24T15:12:35.750598Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-24T15:12:35.752106Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-24T15:12:35.753059Z","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-24T15:12:35.756941Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ec9077c81c499df2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-24T15:12:35.758079Z","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-24T15:12:35.758166Z","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-24T15:12:35.758178Z","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-24T15:12:35.758066Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ec9077c81c499df2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-24T15:12:35.758565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 switched to configuration voters=(17046256290949078514)"} {"level":"info","ts":"2026-08-24T15:12:35.75886Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7e82d3f5f740d3fb","local-member-id":"ec9077c81c499df2","added-peer-id":"ec9077c81c499df2","added-peer-peer-urls":["https://199.19.213.119:2380"]} {"level":"info","ts":"2026-08-24T15:12:35.763343Z","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-24T15:12:35.763581Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ec9077c81c499df2","initial-advertise-peer-urls":["https://199.19.213.119:2380"],"listen-peer-urls":["https://199.19.213.119:2380"],"advertise-client-urls":["https://199.19.213.119:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.119:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-24T15:12:35.763608Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-24T15:12:35.763731Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.119:2380"} {"level":"info","ts":"2026-08-24T15:12:35.763748Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.119:2380"} {"level":"info","ts":"2026-08-24T15:12:35.845143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 is starting a new election at term 1"} {"level":"info","ts":"2026-08-24T15:12:35.845221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-24T15:12:35.845261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 received MsgPreVoteResp from ec9077c81c499df2 at term 1"} {"level":"info","ts":"2026-08-24T15:12:35.845276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 became candidate at term 2"} {"level":"info","ts":"2026-08-24T15:12:35.845282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 received MsgVoteResp from ec9077c81c499df2 at term 2"} {"level":"info","ts":"2026-08-24T15:12:35.84529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 became leader at term 2"} {"level":"info","ts":"2026-08-24T15:12:35.845297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ec9077c81c499df2 elected leader ec9077c81c499df2 at term 2"} {"level":"info","ts":"2026-08-24T15:12:35.84638Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ec9077c81c499df2","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.119:2379]}","request-path":"/0/members/ec9077c81c499df2/attributes","cluster-id":"7e82d3f5f740d3fb","publish-timeout":"7s"} {"level":"info","ts":"2026-08-24T15:12:35.846452Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-24T15:12:35.84648Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:12:35.846505Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-24T15:12:35.846846Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-24T15:12:35.846955Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-24T15:12:35.847595Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7e82d3f5f740d3fb","local-member-id":"ec9077c81c499df2","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:12:35.847751Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:12:35.847796Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:12:35.850651Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-24T15:12:35.850857Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.119:2379"} {"level":"warn","ts":"2026-08-24T15:12:40.091554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.824851ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:12:40.091702Z","caller":"traceutil/trace.go:171","msg":"trace[105664111] linearizableReadLoop","detail":"{readStateIndex:222; appliedIndex:221; }","duration":"210.659992ms","start":"2026-08-24T15:12:39.881021Z","end":"2026-08-24T15:12:40.091681Z","steps":["trace[105664111] 'read index received' (duration: 50.082µs)","trace[105664111] 'applied index is now lower than readState.Index' (duration: 210.60863ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:12:40.091748Z","caller":"traceutil/trace.go:171","msg":"trace[1024218766] transaction","detail":"{read_only:false; response_revision:217; number_of_response:1; }","duration":"384.363566ms","start":"2026-08-24T15:12:39.707342Z","end":"2026-08-24T15:12:40.091706Z","steps":["trace[1024218766] 'process raft request' (duration: 71.800271ms)","trace[1024218766] 'compare' (duration: 311.605378ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:12:40.091852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.827795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:12:40.091905Z","caller":"traceutil/trace.go:171","msg":"trace[1754060403] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:217; }","duration":"210.931317ms","start":"2026-08-24T15:12:39.88096Z","end":"2026-08-24T15:12:40.091891Z","steps":["trace[1754060403] 'agreement among raft nodes before linearized reading' (duration: 210.799854ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:12:40.091913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:12:39.707327Z","time spent":"384.505478ms","remote":"127.0.0.1:57612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":756,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:12:40.233309Z","caller":"traceutil/trace.go:171","msg":"trace[1398295801] transaction","detail":"{read_only:false; response_revision:218; number_of_response:1; }","duration":"134.524573ms","start":"2026-08-24T15:12:40.098744Z","end":"2026-08-24T15:12:40.233269Z","steps":["trace[1398295801] 'process raft request' (duration: 119.011186ms)","trace[1398295801] 'compare' (duration: 15.323384ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:13:14.160109Z","caller":"traceutil/trace.go:171","msg":"trace[679480505] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"146.159922ms","start":"2026-08-24T15:13:14.013907Z","end":"2026-08-24T15:13:14.160067Z","steps":["trace[679480505] 'process raft request' (duration: 93.839611ms)","trace[679480505] 'compare' (duration: 51.983616ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:13:19.901324Z","caller":"traceutil/trace.go:171","msg":"trace[802217513] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"384.035242ms","start":"2026-08-24T15:13:19.517257Z","end":"2026-08-24T15:13:19.901292Z","steps":["trace[802217513] 'process raft request' (duration: 383.19331ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:13:19.901749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:13:19.517232Z","time spent":"384.187124ms","remote":"127.0.0.1:57332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:13:20.401885Z","caller":"traceutil/trace.go:171","msg":"trace[375411476] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"383.768215ms","start":"2026-08-24T15:13:20.018092Z","end":"2026-08-24T15:13:20.40186Z","steps":["trace[375411476] 'read index received' (duration: 296.000008ms)","trace[375411476] 'applied index is now lower than readState.Index' (duration: 87.767027ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:13:20.401969Z","caller":"traceutil/trace.go:171","msg":"trace[1957951113] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"444.33411ms","start":"2026-08-24T15:13:19.957586Z","end":"2026-08-24T15:13:20.40192Z","steps":["trace[1957951113] 'process raft request' (duration: 356.577363ms)","trace[1957951113] 'compare' (duration: 87.409892ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:13:20.402119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:13:19.957566Z","time spent":"444.481531ms","remote":"127.0.0.1:57612","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-08-24T15:13:20.402144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.026938ms","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-24T15:13:20.40222Z","caller":"traceutil/trace.go:171","msg":"trace[1624549624] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:630; }","duration":"384.15127ms","start":"2026-08-24T15:13:20.018049Z","end":"2026-08-24T15:13:20.4022Z","steps":["trace[1624549624] 'agreement among raft nodes before linearized reading' (duration: 383.893757ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:13:20.402266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:13:20.018027Z","time spent":"384.227421ms","remote":"127.0.0.1:57512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-24T15:13:33.295162Z","caller":"traceutil/trace.go:171","msg":"trace[105178559] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"268.548919ms","start":"2026-08-24T15:13:33.026583Z","end":"2026-08-24T15:13:33.295132Z","steps":["trace[105178559] 'process raft request' (duration: 268.369647ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:13:33.321837Z","caller":"traceutil/trace.go:171","msg":"trace[47392704] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"137.598232ms","start":"2026-08-24T15:13:33.184207Z","end":"2026-08-24T15:13:33.321805Z","steps":["trace[47392704] 'process raft request' (duration: 137.42768ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:54.02618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.374525ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:14:54.026626Z","caller":"traceutil/trace.go:171","msg":"trace[1271343204] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"350.784361ms","start":"2026-08-24T15:14:53.675812Z","end":"2026-08-24T15:14:54.026596Z","steps":["trace[1271343204] 'process raft request' (duration: 196.875209ms)","trace[1271343204] 'compare' (duration: 153.262164ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:14:54.02676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:53.675791Z","time spent":"350.900101ms","remote":"127.0.0.1:57432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:54.026649Z","caller":"traceutil/trace.go:171","msg":"trace[387556300] linearizableReadLoop","detail":"{readStateIndex:1944; appliedIndex:1943; }","duration":"300.000081ms","start":"2026-08-24T15:14:53.726593Z","end":"2026-08-24T15:14:54.026593Z","steps":["trace[387556300] 'read index received' (duration: 146.029849ms)","trace[387556300] 'applied index is now lower than readState.Index' (duration: 153.967732ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:14:54.028791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.190254ms","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-08-24T15:14:54.028934Z","caller":"traceutil/trace.go:171","msg":"trace[1416228736] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1876; }","duration":"302.373555ms","start":"2026-08-24T15:14:53.726542Z","end":"2026-08-24T15:14:54.028915Z","steps":["trace[1416228736] 'agreement among raft nodes before linearized reading' (duration: 300.160343ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:54.029024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:53.726521Z","time spent":"302.469016ms","remote":"127.0.0.1:57512","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-24T15:14:54.029093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.357158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9bf7ff75-8204-448e-81ff-c56a99ae86ab\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-08-24T15:14:54.029189Z","caller":"traceutil/trace.go:171","msg":"trace[1119659159] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9bf7ff75-8204-448e-81ff-c56a99ae86ab; range_end:; response_count:1; response_revision:1876; }","duration":"105.497379ms","start":"2026-08-24T15:14:53.923672Z","end":"2026-08-24T15:14:54.02917Z","steps":["trace[1119659159] 'agreement among raft nodes before linearized reading' (duration: 105.332996ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:54.492863Z","caller":"traceutil/trace.go:171","msg":"trace[1733034867] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"225.887823ms","start":"2026-08-24T15:14:54.266953Z","end":"2026-08-24T15:14:54.492841Z","steps":["trace[1733034867] 'process raft request' (duration: 225.745081ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:05.119385Z","caller":"traceutil/trace.go:171","msg":"trace[1264250817] transaction","detail":"{read_only:false; response_revision:1973; number_of_response:1; }","duration":"167.705274ms","start":"2026-08-24T15:15:04.951652Z","end":"2026-08-24T15:15:05.119358Z","steps":["trace[1264250817] 'process raft request' (duration: 167.547912ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:05.435606Z","caller":"traceutil/trace.go:171","msg":"trace[1933183622] linearizableReadLoop","detail":"{readStateIndex:2045; appliedIndex:2043; }","duration":"482.429427ms","start":"2026-08-24T15:15:04.953139Z","end":"2026-08-24T15:15:05.435568Z","steps":["trace[1933183622] 'read index received' (duration: 166.048937ms)","trace[1933183622] 'applied index is now lower than readState.Index' (duration: 316.37867ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:05.435631Z","caller":"traceutil/trace.go:171","msg":"trace[955385316] transaction","detail":"{read_only:false; response_revision:1974; number_of_response:1; }","duration":"483.220815ms","start":"2026-08-24T15:15:04.952368Z","end":"2026-08-24T15:15:05.435589Z","steps":["trace[955385316] 'process raft request' (duration: 418.289846ms)","trace[955385316] 'compare' (duration: 64.183082ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:05.435692Z","caller":"traceutil/trace.go:171","msg":"trace[1946812667] transaction","detail":"{read_only:false; response_revision:1975; number_of_response:1; }","duration":"354.73434ms","start":"2026-08-24T15:15:05.080919Z","end":"2026-08-24T15:15:05.435653Z","steps":["trace[1946812667] 'process raft request' (duration: 354.460817ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:05.435764Z","caller":"traceutil/trace.go:171","msg":"trace[1526990526] transaction","detail":"{read_only:false; response_revision:1976; number_of_response:1; }","duration":"272.028206ms","start":"2026-08-24T15:15:05.163718Z","end":"2026-08-24T15:15:05.435747Z","steps":["trace[1526990526] 'process raft request' (duration: 271.812054ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:05.435872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:05.080891Z","time spent":"354.876151ms","remote":"127.0.0.1:57512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:15:05.435908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.75753ms","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-24T15:15:05.43596Z","caller":"traceutil/trace.go:171","msg":"trace[1986363666] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1976; }","duration":"482.819361ms","start":"2026-08-24T15:15:04.953129Z","end":"2026-08-24T15:15:05.435948Z","steps":["trace[1986363666] 'agreement among raft nodes before linearized reading' (duration: 482.611119ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:05.435942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:04.952341Z","time spent":"483.380056ms","remote":"127.0.0.1:57512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:15:05.435991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:15:04.95309Z","time spent":"482.896172ms","remote":"127.0.0.1:57512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-24T15:15:27.689687Z","caller":"traceutil/trace.go:171","msg":"trace[92458149] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"182.32328ms","start":"2026-08-24T15:15:27.507343Z","end":"2026-08-24T15:15:27.689666Z","steps":["trace[92458149] 'process raft request' (duration: 174.517231ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:27.689871Z","caller":"traceutil/trace.go:171","msg":"trace[1867968326] linearizableReadLoop","detail":"{readStateIndex:2187; appliedIndex:2184; }","duration":"154.429284ms","start":"2026-08-24T15:15:27.535417Z","end":"2026-08-24T15:15:27.689846Z","steps":["trace[1867968326] 'read index received' (duration: 28.557484ms)","trace[1867968326] 'applied index is now lower than readState.Index' (duration: 125.87076ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:27.689962Z","caller":"traceutil/trace.go:171","msg":"trace[1634445469] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"174.185317ms","start":"2026-08-24T15:15:27.515766Z","end":"2026-08-24T15:15:27.689951Z","steps":["trace[1634445469] 'process raft request' (duration: 173.829862ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:15:27.690065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.634467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:15:27.690098Z","caller":"traceutil/trace.go:171","msg":"trace[1358483341] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:2111; }","duration":"154.714677ms","start":"2026-08-24T15:15:27.535375Z","end":"2026-08-24T15:15:27.690089Z","steps":["trace[1358483341] 'agreement among raft nodes before linearized reading' (duration: 154.619236ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:27.886041Z","caller":"traceutil/trace.go:171","msg":"trace[437466626] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"192.234711ms","start":"2026-08-24T15:15:27.693778Z","end":"2026-08-24T15:15:27.886013Z","steps":["trace[437466626] 'process raft request' (duration: 191.833937ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:27.886556Z","caller":"traceutil/trace.go:171","msg":"trace[1685812852] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"193.151661ms","start":"2026-08-24T15:15:27.693361Z","end":"2026-08-24T15:15:27.886513Z","steps":["trace[1685812852] 'process raft request' (duration: 151.011709ms)","trace[1685812852] 'compare' (duration: 40.945689ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:16:40.699974Z","caller":"traceutil/trace.go:171","msg":"trace[436155128] linearizableReadLoop","detail":"{readStateIndex:2710; appliedIndex:2709; }","duration":"117.599911ms","start":"2026-08-24T15:16:40.582338Z","end":"2026-08-24T15:16:40.699938Z","steps":["trace[436155128] 'read index received' (duration: 117.53365ms)","trace[436155128] 'applied index is now lower than readState.Index' (duration: 64.671µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:16:40.700074Z","caller":"traceutil/trace.go:171","msg":"trace[1132811240] transaction","detail":"{read_only:false; response_revision:2617; number_of_response:1; }","duration":"119.012763ms","start":"2026-08-24T15:16:40.581015Z","end":"2026-08-24T15:16:40.700028Z","steps":["trace[1132811240] 'process raft request' (duration: 118.694536ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:16:40.700356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.908268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-24T15:16:40.700441Z","caller":"traceutil/trace.go:171","msg":"trace[1421510258] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2617; }","duration":"118.101092ms","start":"2026-08-24T15:16:40.582315Z","end":"2026-08-24T15:16:40.700416Z","steps":["trace[1421510258] 'agreement among raft nodes before linearized reading' (duration: 117.798035ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:40.711997Z","caller":"traceutil/trace.go:171","msg":"trace[1271257671] transaction","detail":"{read_only:false; response_revision:2618; number_of_response:1; }","duration":"109.226104ms","start":"2026-08-24T15:16:40.602728Z","end":"2026-08-24T15:16:40.711955Z","steps":["trace[1271257671] 'process raft request' (duration: 109.07046ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:56.43238Z","caller":"traceutil/trace.go:171","msg":"trace[1383633113] transaction","detail":"{read_only:false; response_revision:2699; number_of_response:1; }","duration":"126.594207ms","start":"2026-08-24T15:16:56.305765Z","end":"2026-08-24T15:16:56.432359Z","steps":["trace[1383633113] 'process raft request' (duration: 126.477545ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:56.438091Z","caller":"traceutil/trace.go:171","msg":"trace[1452375693] transaction","detail":"{read_only:false; response_revision:2700; number_of_response:1; }","duration":"130.644022ms","start":"2026-08-24T15:16:56.307434Z","end":"2026-08-24T15:16:56.438079Z","steps":["trace[1452375693] 'process raft request' (duration: 130.57244ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:17:01.990283Z","caller":"traceutil/trace.go:171","msg":"trace[228932295] transaction","detail":"{read_only:false; response_revision:2729; number_of_response:1; }","duration":"105.31887ms","start":"2026-08-24T15:17:01.884937Z","end":"2026-08-24T15:17:01.990256Z","steps":["trace[228932295] 'process raft request' (duration: 105.095825ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:36.839085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.587865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-24T15:18:36.839174Z","caller":"traceutil/trace.go:171","msg":"trace[387119956] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:3259; }","duration":"563.693807ms","start":"2026-08-24T15:18:36.275463Z","end":"2026-08-24T15:18:36.839157Z","steps":["trace[387119956] 'count revisions from in-memory index tree' (duration: 563.505274ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:36.839239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:36.275448Z","time spent":"563.768797ms","remote":"127.0.0.1:57440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":21,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"info","ts":"2026-08-24T15:18:36.839446Z","caller":"traceutil/trace.go:171","msg":"trace[1875995656] transaction","detail":"{read_only:false; response_revision:3260; number_of_response:1; }","duration":"359.843558ms","start":"2026-08-24T15:18:36.479591Z","end":"2026-08-24T15:18:36.839434Z","steps":["trace[1875995656] 'process raft request' (duration: 359.724706ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:36.839528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:36.479571Z","time spent":"359.901979ms","remote":"127.0.0.1:57512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:18:36.842291Z","caller":"traceutil/trace.go:171","msg":"trace[1300510666] transaction","detail":"{read_only:false; response_revision:3261; number_of_response:1; }","duration":"362.593382ms","start":"2026-08-24T15:18:36.47964Z","end":"2026-08-24T15:18:36.842233Z","steps":["trace[1300510666] 'process raft request' (duration: 362.390849ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:36.842473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:36.479617Z","time spent":"362.756705ms","remote":"127.0.0.1:57512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:18:37.434753Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11381335354937031787,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:18:37.935536Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11381335354937031787,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:18:38.435864Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11381335354937031787,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:18:38.936446Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11381335354937031787,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:18:39.43724Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11381335354937031787,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:18:39.729633Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.796071153s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-24T15:18:39.858699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00054922s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-24T15:18:39.858781Z","caller":"traceutil/trace.go:171","msg":"trace[357876387] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000684592s","start":"2026-08-24T15:18:37.858081Z","end":"2026-08-24T15:18:39.858766Z","steps":["trace[357876387] 'agreement among raft nodes before linearized reading' (duration: 2.00058132s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:39.858815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:37.858062Z","time spent":"2.000745844s","remote":"127.0.0.1:57228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-24T15:18:40.190724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.241996ms","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-08-24T15:18:40.190864Z","caller":"traceutil/trace.go:171","msg":"trace[1003637395] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:3261; }","duration":"440.387978ms","start":"2026-08-24T15:18:39.750455Z","end":"2026-08-24T15:18:40.190843Z","steps":["trace[1003637395] 'range keys from in-memory index tree' (duration: 440.229136ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.191757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.811962ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:18:40.192036Z","caller":"traceutil/trace.go:171","msg":"trace[356494282] linearizableReadLoop","detail":"{readStateIndex:3387; appliedIndex:3382; }","duration":"3.257943605s","start":"2026-08-24T15:18:36.934078Z","end":"2026-08-24T15:18:40.192021Z","steps":["trace[356494282] 'read index received' (duration: 2.795764168s)","trace[356494282] 'applied index is now lower than readState.Index' (duration: 462.178627ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:18:40.192285Z","caller":"traceutil/trace.go:171","msg":"trace[44838497] transaction","detail":"{read_only:false; response_revision:3262; number_of_response:1; }","duration":"3.258803089s","start":"2026-08-24T15:18:36.933464Z","end":"2026-08-24T15:18:40.192267Z","steps":["trace[44838497] 'process raft request' (duration: 2.796407309s)","trace[44838497] 'compare' (duration: 460.681322ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:18:40.192385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:36.933445Z","time spent":"3.258892921s","remote":"127.0.0.1:57512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:18:40.193686Z","caller":"traceutil/trace.go:171","msg":"trace[114487192] transaction","detail":"{read_only:false; response_revision:3263; number_of_response:1; }","duration":"3.074476547s","start":"2026-08-24T15:18:37.119192Z","end":"2026-08-24T15:18:40.193668Z","steps":["trace[114487192] 'process raft request' (duration: 3.072647289s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.193791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:37.119168Z","time spent":"3.074561038s","remote":"127.0.0.1:57512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:18:40.19396Z","caller":"traceutil/trace.go:171","msg":"trace[1305742051] transaction","detail":"{read_only:false; response_revision:3264; number_of_response:1; }","duration":"2.773353829s","start":"2026-08-24T15:18:37.420591Z","end":"2026-08-24T15:18:40.193945Z","steps":["trace[1305742051] 'process raft request' (duration: 2.771306887s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.194022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:37.420566Z","time spent":"2.773424919s","remote":"127.0.0.1:57512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:18:40.194143Z","caller":"traceutil/trace.go:171","msg":"trace[400443052] transaction","detail":"{read_only:false; response_revision:3265; number_of_response:1; }","duration":"1.348875255s","start":"2026-08-24T15:18:38.845259Z","end":"2026-08-24T15:18:40.194134Z","steps":["trace[400443052] 'process raft request' (duration: 1.34667407s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.194197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:38.845227Z","time spent":"1.348942525s","remote":"127.0.0.1:57512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:18:40.19431Z","caller":"traceutil/trace.go:171","msg":"trace[1123391098] transaction","detail":"{read_only:false; response_revision:3266; number_of_response:1; }","duration":"1.348277026s","start":"2026-08-24T15:18:38.846025Z","end":"2026-08-24T15:18:40.194302Z","steps":["trace[1123391098] 'process raft request' (duration: 1.345936649s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.194363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:38.84601Z","time spent":"1.348326347s","remote":"127.0.0.1:57512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:18:40.194476Z","caller":"traceutil/trace.go:171","msg":"trace[1388807195] transaction","detail":"{read_only:false; response_revision:3267; number_of_response:1; }","duration":"522.437314ms","start":"2026-08-24T15:18:39.67203Z","end":"2026-08-24T15:18:40.194467Z","steps":["trace[1388807195] 'process raft request' (duration: 519.960544ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.194531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:39.672012Z","time spent":"522.489766ms","remote":"127.0.0.1:57512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:18:40.194761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.260669809s","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-24T15:18:40.194831Z","caller":"traceutil/trace.go:171","msg":"trace[1754863255] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3267; }","duration":"3.26077064s","start":"2026-08-24T15:18:36.934045Z","end":"2026-08-24T15:18:40.194815Z","steps":["trace[1754863255] 'agreement among raft nodes before linearized reading' (duration: 3.260581787s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.194861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:36.934037Z","time spent":"3.260818051s","remote":"127.0.0.1:57512","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-24T15:18:40.194961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.975717808s","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-08-24T15:18:40.194994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.536139109s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-24T15:18:40.194986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.862532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:18:40.195013Z","caller":"traceutil/trace.go:171","msg":"trace[1329703637] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3267; }","duration":"2.975812159s","start":"2026-08-24T15:18:37.219188Z","end":"2026-08-24T15:18:40.195001Z","steps":["trace[1329703637] 'agreement among raft nodes before linearized reading' (duration: 2.975640937s)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:18:40.19502Z","caller":"traceutil/trace.go:171","msg":"trace[623741930] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:3267; }","duration":"2.53620286s","start":"2026-08-24T15:18:37.658808Z","end":"2026-08-24T15:18:40.195011Z","steps":["trace[623741930] 'agreement among raft nodes before linearized reading' (duration: 2.536153859s)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:18:40.195034Z","caller":"traceutil/trace.go:171","msg":"trace[1523191013] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3267; }","duration":"335.922763ms","start":"2026-08-24T15:18:39.859096Z","end":"2026-08-24T15:18:40.195019Z","steps":["trace[1523191013] 'agreement among raft nodes before linearized reading' (duration: 335.861542ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.195071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:39.859086Z","time spent":"335.978803ms","remote":"127.0.0.1:57234","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-08-24T15:18:40.195079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.186123913s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"warn","ts":"2026-08-24T15:18:40.195064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.18596989s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:130922"} {"level":"warn","ts":"2026-08-24T15:18:40.195095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.598800988s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-08-24T15:18:40.195102Z","caller":"traceutil/trace.go:171","msg":"trace[504392831] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:3267; }","duration":"2.186163283s","start":"2026-08-24T15:18:38.008932Z","end":"2026-08-24T15:18:40.195096Z","steps":["trace[504392831] 'agreement among raft nodes before linearized reading' (duration: 2.186121792s)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:18:40.195113Z","caller":"traceutil/trace.go:171","msg":"trace[683323096] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3267; }","duration":"2.598861578s","start":"2026-08-24T15:18:37.596246Z","end":"2026-08-24T15:18:40.195108Z","steps":["trace[683323096] 'agreement among raft nodes before linearized reading' (duration: 2.598809627s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.195127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:37.596226Z","time spent":"2.598897839s","remote":"127.0.0.1:57512","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":"warn","ts":"2026-08-24T15:18:40.195126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:38.008926Z","time spent":"2.186195903s","remote":"127.0.0.1:57304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":141,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"info","ts":"2026-08-24T15:18:40.195123Z","caller":"traceutil/trace.go:171","msg":"trace[1689331296] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:3267; }","duration":"2.186068511s","start":"2026-08-24T15:18:38.009039Z","end":"2026-08-24T15:18:40.195107Z","steps":["trace[1689331296] 'agreement among raft nodes before linearized reading' (duration: 2.185835367s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.195161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:38.009018Z","time spent":"2.186132943s","remote":"127.0.0.1:57294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":130945,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-08-24T15:18:40.195043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:37.658789Z","time spent":"2.536247991s","remote":"127.0.0.1:54006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:18:40.195043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:37.21917Z","time spent":"2.9758682s","remote":"127.0.0.1:57512","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-24T15:18:40.195472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.070173149s","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-24T15:18:40.195518Z","caller":"traceutil/trace.go:171","msg":"trace[993341929] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3267; }","duration":"2.070265579s","start":"2026-08-24T15:18:38.125243Z","end":"2026-08-24T15:18:40.195508Z","steps":["trace[993341929] 'agreement among raft nodes before linearized reading' (duration: 2.070142867s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.19555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:38.12522Z","time spent":"2.070323191s","remote":"127.0.0.1:57512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-24T15:20:25.366785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.528854ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:20:25.367028Z","caller":"traceutil/trace.go:171","msg":"trace[44663315] transaction","detail":"{read_only:false; response_revision:3983; number_of_response:1; }","duration":"179.166498ms","start":"2026-08-24T15:20:25.187831Z","end":"2026-08-24T15:20:25.366997Z","steps":["trace[44663315] 'process raft request' (duration: 58.33138ms)","trace[44663315] 'compare' (duration: 120.400953ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:20:25.636682Z","caller":"traceutil/trace.go:171","msg":"trace[1952658484] transaction","detail":"{read_only:false; response_revision:3984; number_of_response:1; }","duration":"228.633607ms","start":"2026-08-24T15:20:25.408018Z","end":"2026-08-24T15:20:25.636652Z","steps":["trace[1952658484] 'process raft request' (duration: 193.803919ms)","trace[1952658484] 'compare' (duration: 34.716286ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:20:39.532605Z","caller":"traceutil/trace.go:171","msg":"trace[1012344113] transaction","detail":"{read_only:false; response_revision:4534; number_of_response:1; }","duration":"104.601537ms","start":"2026-08-24T15:20:39.427978Z","end":"2026-08-24T15:20:39.532579Z","steps":["trace[1012344113] 'process raft request' (duration: 104.483836ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:20:45.195018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.440162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-24T15:20:45.195129Z","caller":"traceutil/trace.go:171","msg":"trace[1922893400] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4664; }","duration":"253.571854ms","start":"2026-08-24T15:20:44.941533Z","end":"2026-08-24T15:20:45.195105Z","steps":["trace[1922893400] 'range keys from in-memory index tree' (duration: 253.155308ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:20:45.195099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.737752ms","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-24T15:20:45.195215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.097677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-08-24T15:20:45.195235Z","caller":"traceutil/trace.go:171","msg":"trace[1335176548] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4664; }","duration":"278.919635ms","start":"2026-08-24T15:20:44.916295Z","end":"2026-08-24T15:20:45.195215Z","steps":["trace[1335176548] 'range keys from in-memory index tree' (duration: 278.444359ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:20:45.195248Z","caller":"traceutil/trace.go:171","msg":"trace[408734088] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4664; }","duration":"250.153337ms","start":"2026-08-24T15:20:44.945084Z","end":"2026-08-24T15:20:45.195238Z","steps":["trace[408734088] 'range keys from in-memory index tree' (duration: 249.999326ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:20:45.19533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.642486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-24T15:20:45.195394Z","caller":"traceutil/trace.go:171","msg":"trace[1862428011] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4664; }","duration":"222.737157ms","start":"2026-08-24T15:20:44.972639Z","end":"2026-08-24T15:20:45.195376Z","steps":["trace[1862428011] 'count revisions from in-memory index tree' (duration: 222.576915ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:20:45.195527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.130671ms","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-24T15:20:45.195659Z","caller":"traceutil/trace.go:171","msg":"trace[1382880443] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4664; }","duration":"254.289453ms","start":"2026-08-24T15:20:44.941325Z","end":"2026-08-24T15:20:45.195615Z","steps":["trace[1382880443] 'range keys from in-memory index tree' (duration: 253.844498ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:20:45.214038Z","caller":"traceutil/trace.go:171","msg":"trace[126484122] linearizableReadLoop","detail":"{readStateIndex:4833; appliedIndex:4832; }","duration":"140.34451ms","start":"2026-08-24T15:20:45.073664Z","end":"2026-08-24T15:20:45.214009Z","steps":["trace[126484122] 'read index received' (duration: 140.196788ms)","trace[126484122] 'applied index is now lower than readState.Index' (duration: 146.732µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:20:45.214214Z","caller":"traceutil/trace.go:171","msg":"trace[1625819150] transaction","detail":"{read_only:false; response_revision:4665; number_of_response:1; }","duration":"205.995144ms","start":"2026-08-24T15:20:45.008185Z","end":"2026-08-24T15:20:45.21418Z","steps":["trace[1625819150] 'process raft request' (duration: 205.66981ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:20:45.21433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.587723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-93e7e52e-6071-40e8-a21d-32d56d7fd612\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-08-24T15:20:45.214385Z","caller":"traceutil/trace.go:171","msg":"trace[683140829] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-93e7e52e-6071-40e8-a21d-32d56d7fd612; range_end:; response_count:1; response_revision:4665; }","duration":"140.753104ms","start":"2026-08-24T15:20:45.073614Z","end":"2026-08-24T15:20:45.214367Z","steps":["trace[683140829] 'agreement among raft nodes before linearized reading' (duration: 140.503071ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:20:59.008599Z","caller":"traceutil/trace.go:171","msg":"trace[2078590835] linearizableReadLoop","detail":"{readStateIndex:5023; appliedIndex:5020; }","duration":"149.842555ms","start":"2026-08-24T15:20:58.858729Z","end":"2026-08-24T15:20:59.008572Z","steps":["trace[2078590835] 'read index received' (duration: 86.882047ms)","trace[2078590835] 'applied index is now lower than readState.Index' (duration: 62.959378ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:20:59.008774Z","caller":"traceutil/trace.go:171","msg":"trace[1862275687] transaction","detail":"{read_only:false; response_revision:4847; number_of_response:1; }","duration":"173.970776ms","start":"2026-08-24T15:20:58.834768Z","end":"2026-08-24T15:20:59.008738Z","steps":["trace[1862275687] 'process raft request' (duration: 173.639032ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:20:59.00885Z","caller":"traceutil/trace.go:171","msg":"trace[715887043] transaction","detail":"{read_only:false; response_revision:4846; number_of_response:1; }","duration":"175.02012ms","start":"2026-08-24T15:20:58.833821Z","end":"2026-08-24T15:20:59.008841Z","steps":["trace[715887043] 'process raft request' (duration: 111.793068ms)","trace[715887043] 'compare' (duration: 62.539653ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:20:59.008788Z","caller":"traceutil/trace.go:171","msg":"trace[730972708] transaction","detail":"{read_only:false; response_revision:4848; number_of_response:1; }","duration":"164.481631ms","start":"2026-08-24T15:20:58.844281Z","end":"2026-08-24T15:20:59.008762Z","steps":["trace[730972708] 'process raft request' (duration: 164.242727ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:20:59.009198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.455473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:20:59.009231Z","caller":"traceutil/trace.go:171","msg":"trace[201507203] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4848; }","duration":"150.524984ms","start":"2026-08-24T15:20:58.858697Z","end":"2026-08-24T15:20:59.009222Z","steps":["trace[201507203] 'agreement among raft nodes before linearized reading' (duration: 150.384312ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:20:59.009347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.186833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-24T15:20:59.009418Z","caller":"traceutil/trace.go:171","msg":"trace[1387327228] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4848; }","duration":"106.310316ms","start":"2026-08-24T15:20:58.903091Z","end":"2026-08-24T15:20:59.009401Z","steps":["trace[1387327228] 'agreement among raft nodes before linearized reading' (duration: 106.108353ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:20:59.009524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.783815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:20:59.009579Z","caller":"traceutil/trace.go:171","msg":"trace[1765286262] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:4848; }","duration":"104.893806ms","start":"2026-08-24T15:20:58.904672Z","end":"2026-08-24T15:20:59.009566Z","steps":["trace[1765286262] 'agreement among raft nodes before linearized reading' (duration: 104.770504ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:36.497693Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2910} {"level":"info","ts":"2026-08-24T15:22:36.588602Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2910,"took":"89.457545ms","hash":2290665404,"current-db-size-bytes":55431168,"current-db-size":"55 MB","current-db-size-in-use-bytes":29769728,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-24T15:22:36.588649Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2290665404,"revision":2910,"compact-revision":-1} {"level":"info","ts":"2026-08-24T15:27:36.505558Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5617} {"level":"info","ts":"2026-08-24T15:27:36.599177Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5617,"took":"92.529407ms","hash":2251619951,"current-db-size-bytes":55431168,"current-db-size":"55 MB","current-db-size-in-use-bytes":18456576,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-24T15:27:36.599228Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2251619951,"revision":5617,"compact-revision":2910}