{"level":"warn","ts":"2026-08-11T08:13:11.335127Z","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:13:11.335215Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.115: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.115:2380","--initial-cluster=instance=https://199.19.213.115:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.115:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.115: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:13:11.335279Z","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:13:11.335316Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.115:2380"]} {"level":"info","ts":"2026-08-11T08:13:11.335355Z","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:13:11.335996Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.115:2379"]} {"level":"info","ts":"2026-08-11T08:13:11.336069Z","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.115:2380"],"listen-peer-urls":["https://199.19.213.115:2380"],"advertise-client-urls":["https://199.19.213.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.115: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:13:11.340434Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.093225ms"} {"level":"info","ts":"2026-08-11T08:13:11.351548Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"76964ef0a001678d","cluster-id":"a26f37ac4c69834d"} {"level":"info","ts":"2026-08-11T08:13:11.351667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"76964ef0a001678d switched to configuration voters=()"} {"level":"info","ts":"2026-08-11T08:13:11.351698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"76964ef0a001678d became follower at term 0"} {"level":"info","ts":"2026-08-11T08:13:11.35172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 76964ef0a001678d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-11T08:13:11.35173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"76964ef0a001678d became follower at term 1"} {"level":"info","ts":"2026-08-11T08:13:11.351772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"76964ef0a001678d switched to configuration voters=(8545104138365659021)"} {"level":"warn","ts":"2026-08-11T08:13:11.360679Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-11T08:13:11.362248Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-11T08:13:11.364134Z","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:13:11.367513Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"76964ef0a001678d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-11T08:13:11.367798Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"76964ef0a001678d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-11T08:13:11.367989Z","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:13:11.368811Z","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:13:11.368901Z","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:13:11.371373Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"76964ef0a001678d switched to configuration voters=(8545104138365659021)"} {"level":"info","ts":"2026-08-11T08:13:11.371489Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a26f37ac4c69834d","local-member-id":"76964ef0a001678d","added-peer-id":"76964ef0a001678d","added-peer-peer-urls":["https://199.19.213.115:2380"]} {"level":"info","ts":"2026-08-11T08:13:11.373545Z","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:13:11.373683Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.115:2380"} {"level":"info","ts":"2026-08-11T08:13:11.373729Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"76964ef0a001678d","initial-advertise-peer-urls":["https://199.19.213.115:2380"],"listen-peer-urls":["https://199.19.213.115:2380"],"advertise-client-urls":["https://199.19.213.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-11T08:13:11.373733Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.115:2380"} {"level":"info","ts":"2026-08-11T08:13:11.373757Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-11T08:13:11.752169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"76964ef0a001678d is starting a new election at term 1"} {"level":"info","ts":"2026-08-11T08:13:11.752228Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"76964ef0a001678d became pre-candidate at term 1"} {"level":"info","ts":"2026-08-11T08:13:11.752251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"76964ef0a001678d received MsgPreVoteResp from 76964ef0a001678d at term 1"} {"level":"info","ts":"2026-08-11T08:13:11.752269Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"76964ef0a001678d became candidate at term 2"} {"level":"info","ts":"2026-08-11T08:13:11.752284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"76964ef0a001678d received MsgVoteResp from 76964ef0a001678d at term 2"} {"level":"info","ts":"2026-08-11T08:13:11.752299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"76964ef0a001678d became leader at term 2"} {"level":"info","ts":"2026-08-11T08:13:11.752313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 76964ef0a001678d elected leader 76964ef0a001678d at term 2"} {"level":"info","ts":"2026-08-11T08:13:11.753705Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:13:11.754465Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T08:13:11.754487Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T08:13:11.754873Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"76964ef0a001678d","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.115:2379]}","request-path":"/0/members/76964ef0a001678d/attributes","cluster-id":"a26f37ac4c69834d","publish-timeout":"7s"} {"level":"info","ts":"2026-08-11T08:13:11.755052Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-11T08:13:11.75541Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-11T08:13:11.757036Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.115:2379"} {"level":"info","ts":"2026-08-11T08:13:11.757702Z","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:13:11.759408Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a26f37ac4c69834d","local-member-id":"76964ef0a001678d","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:13:11.759551Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:13:11.759586Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:13:20.480444Z","caller":"traceutil/trace.go:171","msg":"trace[1891257033] linearizableReadLoop","detail":"{readStateIndex:310; appliedIndex:309; }","duration":"136.959314ms","start":"2026-08-11T08:13:20.343461Z","end":"2026-08-11T08:13:20.480421Z","steps":["trace[1891257033] 'read index received' (duration: 130.883881ms)","trace[1891257033] 'applied index is now lower than readState.Index' (duration: 6.074763ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:13:20.480548Z","caller":"traceutil/trace.go:171","msg":"trace[1696213131] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"147.453019ms","start":"2026-08-11T08:13:20.333079Z","end":"2026-08-11T08:13:20.480532Z","steps":["trace[1696213131] 'process raft request' (duration: 141.332455ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:13:20.480625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.116538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-08-11T08:13:20.480675Z","caller":"traceutil/trace.go:171","msg":"trace[1510312382] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:296; }","duration":"137.239122ms","start":"2026-08-11T08:13:20.343427Z","end":"2026-08-11T08:13:20.480666Z","steps":["trace[1510312382] 'agreement among raft nodes before linearized reading' (duration: 137.117879ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:13:26.476237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.229389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:13:26.476335Z","caller":"traceutil/trace.go:171","msg":"trace[905311664] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:366; }","duration":"137.428832ms","start":"2026-08-11T08:13:26.338888Z","end":"2026-08-11T08:13:26.476317Z","steps":["trace[905311664] 'range keys from in-memory index tree' (duration: 137.070435ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:13:27.024362Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7461796010259855953,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-11T08:13:27.081712Z","caller":"traceutil/trace.go:171","msg":"trace[908087729] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"575.528125ms","start":"2026-08-11T08:13:26.506161Z","end":"2026-08-11T08:13:27.081689Z","steps":["trace[908087729] 'process raft request' (duration: 575.400623ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:13:27.082311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:13:26.506142Z","time spent":"575.638148ms","remote":"127.0.0.1:39056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:13:27.377405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.717034ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T08:13:27.378182Z","caller":"traceutil/trace.go:171","msg":"trace[539531759] linearizableReadLoop","detail":"{readStateIndex:385; appliedIndex:382; }","duration":"853.998331ms","start":"2026-08-11T08:13:26.524167Z","end":"2026-08-11T08:13:27.378166Z","steps":["trace[539531759] 'read index received' (duration: 557.40411ms)","trace[539531759] 'applied index is now lower than readState.Index' (duration: 296.593161ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:13:27.378199Z","caller":"traceutil/trace.go:171","msg":"trace[1796677979] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"871.282411ms","start":"2026-08-11T08:13:26.506881Z","end":"2026-08-11T08:13:27.378163Z","steps":["trace[1796677979] 'process raft request' (duration: 717.626157ms)","trace[1796677979] 'compare' (duration: 152.633073ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:13:27.378356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:13:26.506871Z","time spent":"871.406023ms","remote":"127.0.0.1:39056","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-11T08:13:27.378486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.834312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4795"} {"level":"info","ts":"2026-08-11T08:13:27.378697Z","caller":"traceutil/trace.go:171","msg":"trace[54745719] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:369; }","duration":"704.097318ms","start":"2026-08-11T08:13:26.674517Z","end":"2026-08-11T08:13:27.378614Z","steps":["trace[54745719] 'agreement among raft nodes before linearized reading' (duration: 703.807051ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:13:27.378505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.375379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-08-11T08:13:27.378806Z","caller":"traceutil/trace.go:171","msg":"trace[387592938] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"635.501254ms","start":"2026-08-11T08:13:26.742706Z","end":"2026-08-11T08:13:27.378207Z","steps":["trace[387592938] 'process raft request' (duration: 635.386092ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:13:27.37886Z","caller":"traceutil/trace.go:171","msg":"trace[656406875] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:369; }","duration":"235.738616ms","start":"2026-08-11T08:13:27.143076Z","end":"2026-08-11T08:13:27.378815Z","steps":["trace[656406875] 'agreement among raft nodes before linearized reading' (duration: 235.275497ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:13:27.378901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:13:26.742682Z","time spent":"636.172387ms","remote":"127.0.0.1:39056","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-11T08:13:27.378881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:13:26.674501Z","time spent":"704.299122ms","remote":"127.0.0.1:38982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":4818,"request content":"key:\"/registry/pods/kube-system/kube-vip-instance\" "} {"level":"warn","ts":"2026-08-11T08:13:27.37828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.108674ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:13:27.379177Z","caller":"traceutil/trace.go:171","msg":"trace[14726762] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:369; }","duration":"855.003552ms","start":"2026-08-11T08:13:26.524159Z","end":"2026-08-11T08:13:27.379163Z","steps":["trace[14726762] 'agreement among raft nodes before linearized reading' (duration: 854.095754ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:13:37.407848Z","caller":"traceutil/trace.go:171","msg":"trace[1742555920] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"198.382116ms","start":"2026-08-11T08:13:37.209439Z","end":"2026-08-11T08:13:37.407821Z","steps":["trace[1742555920] 'process raft request' (duration: 198.216393ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:13:49.118728Z","caller":"traceutil/trace.go:171","msg":"trace[28754982] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"218.376939ms","start":"2026-08-11T08:13:48.900312Z","end":"2026-08-11T08:13:49.118689Z","steps":["trace[28754982] 'process raft request' (duration: 218.253847ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:13:49.126923Z","caller":"traceutil/trace.go:171","msg":"trace[727461162] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"214.600045ms","start":"2026-08-11T08:13:48.912305Z","end":"2026-08-11T08:13:49.126905Z","steps":["trace[727461162] 'process raft request' (duration: 214.389471ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:13:49.126997Z","caller":"traceutil/trace.go:171","msg":"trace[111256158] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"221.223445ms","start":"2026-08-11T08:13:48.905756Z","end":"2026-08-11T08:13:49.12698Z","steps":["trace[111256158] 'process raft request' (duration: 220.860658ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:13:49.126994Z","caller":"traceutil/trace.go:171","msg":"trace[1942537097] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"203.142864ms","start":"2026-08-11T08:13:48.923814Z","end":"2026-08-11T08:13:49.126957Z","steps":["trace[1942537097] 'process raft request' (duration: 202.95074ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:13:49.127045Z","caller":"traceutil/trace.go:171","msg":"trace[1408702255] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"207.659431ms","start":"2026-08-11T08:13:48.919377Z","end":"2026-08-11T08:13:49.127037Z","steps":["trace[1408702255] 'process raft request' (duration: 207.356345ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:13:49.127067Z","caller":"traceutil/trace.go:171","msg":"trace[60008704] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"199.499522ms","start":"2026-08-11T08:13:48.927551Z","end":"2026-08-11T08:13:49.127051Z","steps":["trace[60008704] 'process raft request' (duration: 199.259626ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:13:49.127101Z","caller":"traceutil/trace.go:171","msg":"trace[536872027] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"198.41013ms","start":"2026-08-11T08:13:48.928685Z","end":"2026-08-11T08:13:49.127095Z","steps":["trace[536872027] 'process raft request' (duration: 198.155866ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:13:49.127138Z","caller":"traceutil/trace.go:171","msg":"trace[1689347101] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"221.180614ms","start":"2026-08-11T08:13:48.905954Z","end":"2026-08-11T08:13:49.127134Z","steps":["trace[1689347101] 'process raft request' (duration: 220.719645ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:13:49.126995Z","caller":"traceutil/trace.go:171","msg":"trace[1214525498] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"211.462285ms","start":"2026-08-11T08:13:48.915506Z","end":"2026-08-11T08:13:49.126969Z","steps":["trace[1214525498] 'process raft request' (duration: 211.209509ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:13:49.127182Z","caller":"traceutil/trace.go:171","msg":"trace[1715200284] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"201.676195ms","start":"2026-08-11T08:13:48.925482Z","end":"2026-08-11T08:13:49.127159Z","steps":["trace[1715200284] 'process raft request' (duration: 201.305007ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:13:49.127275Z","caller":"traceutil/trace.go:171","msg":"trace[372495529] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"165.413938ms","start":"2026-08-11T08:13:48.961856Z","end":"2026-08-11T08:13:49.12727Z","steps":["trace[372495529] 'process raft request' (duration: 165.06183ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:13:51.706444Z","caller":"traceutil/trace.go:171","msg":"trace[2029835045] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"101.396947ms","start":"2026-08-11T08:13:51.605024Z","end":"2026-08-11T08:13:51.70642Z","steps":["trace[2029835045] 'process raft request' (duration: 96.423179ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:13:55.586394Z","caller":"traceutil/trace.go:171","msg":"trace[248329601] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"136.448333ms","start":"2026-08-11T08:13:55.449911Z","end":"2026-08-11T08:13:55.58636Z","steps":["trace[248329601] 'process raft request' (duration: 135.857261ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:13:56.117665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.147857ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T08:13:56.117774Z","caller":"traceutil/trace.go:171","msg":"trace[1625131385] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"526.848174ms","start":"2026-08-11T08:13:55.590905Z","end":"2026-08-11T08:13:56.117753Z","steps":["trace[1625131385] 'process raft request' (duration: 222.513103ms)","trace[1625131385] 'compare' (duration: 303.984474ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:13:56.117849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:13:55.590884Z","time spent":"526.927215ms","remote":"127.0.0.1:39056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:13:56.160112Z","caller":"traceutil/trace.go:171","msg":"trace[1525512340] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:620; }","duration":"441.335822ms","start":"2026-08-11T08:13:55.718751Z","end":"2026-08-11T08:13:56.160087Z","steps":["trace[1525512340] 'read index received' (duration: 94.684568ms)","trace[1525512340] 'applied index is now lower than readState.Index' (duration: 346.650194ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:13:56.160273Z","caller":"traceutil/trace.go:171","msg":"trace[1780294311] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"503.517994ms","start":"2026-08-11T08:13:55.656717Z","end":"2026-08-11T08:13:56.160235Z","steps":["trace[1780294311] 'process raft request' (duration: 503.204618ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:13:56.160473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:13:55.656691Z","time spent":"503.665426ms","remote":"127.0.0.1:39040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T08:13:56.160588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.882905ms","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:13:56.16073Z","caller":"traceutil/trace.go:171","msg":"trace[485211693] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:597; }","duration":"440.053138ms","start":"2026-08-11T08:13:55.720663Z","end":"2026-08-11T08:13:56.160716Z","steps":["trace[485211693] 'agreement among raft nodes before linearized reading' (duration: 439.781063ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:13:56.160777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:13:55.720652Z","time spent":"440.113759ms","remote":"127.0.0.1:39056","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:13:56.160825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.943291ms","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:13:56.160898Z","caller":"traceutil/trace.go:171","msg":"trace[2046589807] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:597; }","duration":"261.058474ms","start":"2026-08-11T08:13:55.899825Z","end":"2026-08-11T08:13:56.160883Z","steps":["trace[2046589807] 'agreement among raft nodes before linearized reading' (duration: 260.86683ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:13:56.160615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.802563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-11T08:13:56.160946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.100074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-v97qd\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-11T08:13:56.160958Z","caller":"traceutil/trace.go:171","msg":"trace[968139744] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:597; }","duration":"442.25957ms","start":"2026-08-11T08:13:55.718684Z","end":"2026-08-11T08:13:56.160944Z","steps":["trace[968139744] 'agreement among raft nodes before linearized reading' (duration: 441.566447ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:13:56.161024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:13:55.718663Z","time spent":"442.346583ms","remote":"127.0.0.1:39056","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":"info","ts":"2026-08-11T08:13:56.161026Z","caller":"traceutil/trace.go:171","msg":"trace[1784402410] range","detail":"{range_begin:/registry/pods/kube-system/cilium-v97qd; range_end:; response_count:1; response_revision:597; }","duration":"377.208726ms","start":"2026-08-11T08:13:55.783795Z","end":"2026-08-11T08:13:56.161004Z","steps":["trace[1784402410] 'agreement among raft nodes before linearized reading' (duration: 376.883809ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:13:56.161068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:13:55.78378Z","time spent":"377.280216ms","remote":"127.0.0.1:38982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-v97qd\" "} {"level":"warn","ts":"2026-08-11T08:13:56.707898Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7461796010259856449,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T08:13:57.208655Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7461796010259856449,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T08:13:57.305947Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.10549148s","expected-duration":"1s"} {"level":"info","ts":"2026-08-11T08:13:57.313364Z","caller":"traceutil/trace.go:171","msg":"trace[770302362] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:625; }","duration":"1.106088282s","start":"2026-08-11T08:13:56.207238Z","end":"2026-08-11T08:13:57.313327Z","steps":["trace[770302362] 'read index received' (duration: 1.098893733s)","trace[770302362] 'applied index is now lower than readState.Index' (duration: 7.193069ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:13:57.313445Z","caller":"traceutil/trace.go:171","msg":"trace[1035473568] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"1.138417374s","start":"2026-08-11T08:13:56.175006Z","end":"2026-08-11T08:13:57.313423Z","steps":["trace[1035473568] 'process raft request' (duration: 1.131212996s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:13:57.313532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"975.818971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T08:13:57.313573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:13:56.174989Z","time spent":"1.138504965s","remote":"127.0.0.1:38982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:13:57.313587Z","caller":"traceutil/trace.go:171","msg":"trace[874723295] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"975.907882ms","start":"2026-08-11T08:13:56.337665Z","end":"2026-08-11T08:13:57.313573Z","steps":["trace[874723295] 'agreement among raft nodes before linearized reading' (duration: 975.80717ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:13:57.313705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:13:56.337651Z","time spent":"976.022244ms","remote":"127.0.0.1:38796","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-11T08:13:57.31354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.106274325s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:13:57.313843Z","caller":"traceutil/trace.go:171","msg":"trace[2067987116] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:601; }","duration":"1.10658828s","start":"2026-08-11T08:13:56.207193Z","end":"2026-08-11T08:13:57.313781Z","steps":["trace[2067987116] 'agreement among raft nodes before linearized reading' (duration: 1.106273574s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:13:57.313936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:13:56.207172Z","time spent":"1.106722312s","remote":"127.0.0.1:38938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" "} {"level":"info","ts":"2026-08-11T08:13:59.073525Z","caller":"traceutil/trace.go:171","msg":"trace[1743989432] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"172.455764ms","start":"2026-08-11T08:13:58.901045Z","end":"2026-08-11T08:13:59.0735Z","steps":["trace[1743989432] 'process raft request' (duration: 170.379164ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:14:12.361778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.219038ms","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:14:12.361976Z","caller":"traceutil/trace.go:171","msg":"trace[1027047994] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:753; }","duration":"177.461832ms","start":"2026-08-11T08:14:12.18449Z","end":"2026-08-11T08:14:12.361952Z","steps":["trace[1027047994] 'range keys from in-memory index tree' (duration: 177.026964ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:15:41.022243Z","caller":"traceutil/trace.go:171","msg":"trace[1758503796] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"116.104996ms","start":"2026-08-11T08:15:40.906112Z","end":"2026-08-11T08:15:41.022217Z","steps":["trace[1758503796] 'process raft request' (duration: 115.640698ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:15:59.209003Z","caller":"traceutil/trace.go:171","msg":"trace[2077275088] linearizableReadLoop","detail":"{readStateIndex:1328; appliedIndex:1327; }","duration":"113.642097ms","start":"2026-08-11T08:15:59.095333Z","end":"2026-08-11T08:15:59.208975Z","steps":["trace[2077275088] 'read index received' (duration: 113.546484ms)","trace[2077275088] 'applied index is now lower than readState.Index' (duration: 93.593µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:15:59.209113Z","caller":"traceutil/trace.go:171","msg":"trace[1429010452] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"148.351664ms","start":"2026-08-11T08:15:59.060709Z","end":"2026-08-11T08:15:59.20906Z","steps":["trace[1429010452] 'process raft request' (duration: 148.097416ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:15:59.209291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.950658ms","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:15:59.209343Z","caller":"traceutil/trace.go:171","msg":"trace[183991446] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1275; }","duration":"114.069132ms","start":"2026-08-11T08:15:59.095261Z","end":"2026-08-11T08:15:59.20933Z","steps":["trace[183991446] 'agreement among raft nodes before linearized reading' (duration: 113.882477ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:16:07.501179Z","caller":"traceutil/trace.go:171","msg":"trace[1929083925] linearizableReadLoop","detail":"{readStateIndex:1363; appliedIndex:1362; }","duration":"256.646525ms","start":"2026-08-11T08:16:07.244511Z","end":"2026-08-11T08:16:07.501158Z","steps":["trace[1929083925] 'read index received' (duration: 256.466289ms)","trace[1929083925] 'applied index is now lower than readState.Index' (duration: 179.226µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:16:07.50129Z","caller":"traceutil/trace.go:171","msg":"trace[745959134] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"260.161864ms","start":"2026-08-11T08:16:07.241087Z","end":"2026-08-11T08:16:07.501249Z","steps":["trace[745959134] 'process raft request' (duration: 259.912395ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:07.501821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.447098ms","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:16:07.501922Z","caller":"traceutil/trace.go:171","msg":"trace[2134210639] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1308; }","duration":"256.980127ms","start":"2026-08-11T08:16:07.244932Z","end":"2026-08-11T08:16:07.501912Z","steps":["trace[2134210639] 'agreement among raft nodes before linearized reading' (duration: 256.409997ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:07.501739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.119798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-11T08:16:07.501808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.287247ms","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:16:07.502008Z","caller":"traceutil/trace.go:171","msg":"trace[568834635] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1308; }","duration":"256.423468ms","start":"2026-08-11T08:16:07.245568Z","end":"2026-08-11T08:16:07.501991Z","steps":["trace[568834635] 'agreement among raft nodes before linearized reading' (duration: 255.855869ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:16:07.502035Z","caller":"traceutil/trace.go:171","msg":"trace[301959347] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1308; }","duration":"257.542856ms","start":"2026-08-11T08:16:07.244476Z","end":"2026-08-11T08:16:07.502019Z","steps":["trace[301959347] 'agreement among raft nodes before linearized reading' (duration: 256.819212ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:16:24.667286Z","caller":"traceutil/trace.go:171","msg":"trace[1302613188] linearizableReadLoop","detail":"{readStateIndex:1429; appliedIndex:1428; }","duration":"128.548893ms","start":"2026-08-11T08:16:24.538715Z","end":"2026-08-11T08:16:24.667264Z","steps":["trace[1302613188] 'read index received' (duration: 128.530752ms)","trace[1302613188] 'applied index is now lower than readState.Index' (duration: 17.341µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:16:24.667481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.747278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:pv-protection-controller\" ","response":"range_response_count:1 size:771"} {"level":"info","ts":"2026-08-11T08:16:24.667438Z","caller":"traceutil/trace.go:171","msg":"trace[2066810028] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"149.711054ms","start":"2026-08-11T08:16:24.517687Z","end":"2026-08-11T08:16:24.667398Z","steps":["trace[2066810028] 'process raft request' (duration: 149.455526ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:16:24.667538Z","caller":"traceutil/trace.go:171","msg":"trace[88299703] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:pv-protection-controller; range_end:; response_count:1; response_revision:1370; }","duration":"128.838032ms","start":"2026-08-11T08:16:24.538675Z","end":"2026-08-11T08:16:24.667513Z","steps":["trace[88299703] 'agreement among raft nodes before linearized reading' (duration: 128.744149ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:24.667611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.769419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:pvc-protection-controller\" ","response":"range_response_count:1 size:775"} {"level":"info","ts":"2026-08-11T08:16:24.667728Z","caller":"traceutil/trace.go:171","msg":"trace[1938725556] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:pvc-protection-controller; range_end:; response_count:1; response_revision:1370; }","duration":"123.887832ms","start":"2026-08-11T08:16:24.543823Z","end":"2026-08-11T08:16:24.667711Z","steps":["trace[1938725556] 'agreement among raft nodes before linearized reading' (duration: 123.667155ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:16:27.853263Z","caller":"traceutil/trace.go:171","msg":"trace[1826878765] transaction","detail":"{read_only:false; response_revision:1381; number_of_response:1; }","duration":"122.464883ms","start":"2026-08-11T08:16:27.730772Z","end":"2026-08-11T08:16:27.853237Z","steps":["trace[1826878765] 'process raft request' (duration: 122.283637ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:16:27.866851Z","caller":"traceutil/trace.go:171","msg":"trace[1225777752] linearizableReadLoop","detail":"{readStateIndex:1442; appliedIndex:1440; }","duration":"128.735273ms","start":"2026-08-11T08:16:27.738095Z","end":"2026-08-11T08:16:27.86683Z","steps":["trace[1225777752] 'read index received' (duration: 115.039726ms)","trace[1225777752] 'applied index is now lower than readState.Index' (duration: 13.694427ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:16:27.866968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.846047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:16:27.867007Z","caller":"traceutil/trace.go:171","msg":"trace[671573818] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1382; }","duration":"128.930471ms","start":"2026-08-11T08:16:27.738062Z","end":"2026-08-11T08:16:27.866993Z","steps":["trace[671573818] 'agreement among raft nodes before linearized reading' (duration: 128.853858ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:16:27.867205Z","caller":"traceutil/trace.go:171","msg":"trace[954626935] transaction","detail":"{read_only:false; response_revision:1382; number_of_response:1; }","duration":"134.222498ms","start":"2026-08-11T08:16:27.732947Z","end":"2026-08-11T08:16:27.86717Z","steps":["trace[954626935] 'process raft request' (duration: 133.772654ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:16:29.99591Z","caller":"traceutil/trace.go:171","msg":"trace[1170955923] linearizableReadLoop","detail":"{readStateIndex:1447; appliedIndex:1446; }","duration":"126.142878ms","start":"2026-08-11T08:16:29.869741Z","end":"2026-08-11T08:16:29.995884Z","steps":["trace[1170955923] 'read index received' (duration: 100.594636ms)","trace[1170955923] 'applied index is now lower than readState.Index' (duration: 25.547022ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:16:29.996056Z","caller":"traceutil/trace.go:171","msg":"trace[624552244] transaction","detail":"{read_only:false; response_revision:1387; number_of_response:1; }","duration":"134.960339ms","start":"2026-08-11T08:16:29.861065Z","end":"2026-08-11T08:16:29.996026Z","steps":["trace[624552244] 'process raft request' (duration: 109.276093ms)","trace[624552244] 'compare' (duration: 25.430748ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:16:29.996175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.412047ms","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:16:29.99622Z","caller":"traceutil/trace.go:171","msg":"trace[1536156545] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1387; }","duration":"126.486939ms","start":"2026-08-11T08:16:29.869723Z","end":"2026-08-11T08:16:29.99621Z","steps":["trace[1536156545] 'agreement among raft nodes before linearized reading' (duration: 126.315575ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:16:32.867721Z","caller":"traceutil/trace.go:171","msg":"trace[177527623] linearizableReadLoop","detail":"{readStateIndex:1458; appliedIndex:1457; }","duration":"126.069673ms","start":"2026-08-11T08:16:32.741635Z","end":"2026-08-11T08:16:32.867704Z","steps":["trace[177527623] 'read index received' (duration: 125.980592ms)","trace[177527623] 'applied index is now lower than readState.Index' (duration: 88.441µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:16:32.86777Z","caller":"traceutil/trace.go:171","msg":"trace[2144739605] transaction","detail":"{read_only:false; response_revision:1397; number_of_response:1; }","duration":"152.768465ms","start":"2026-08-11T08:16:32.714979Z","end":"2026-08-11T08:16:32.867748Z","steps":["trace[2144739605] 'process raft request' (duration: 152.60397ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:32.867945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.29368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-rate-limit\" ","response":"range_response_count:1 size:4456"} {"level":"info","ts":"2026-08-11T08:16:32.867986Z","caller":"traceutil/trace.go:171","msg":"trace[1363701371] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-rate-limit; range_end:; response_count:1; response_revision:1397; }","duration":"126.388245ms","start":"2026-08-11T08:16:32.74159Z","end":"2026-08-11T08:16:32.867978Z","steps":["trace[1363701371] 'agreement among raft nodes before linearized reading' (duration: 126.23181ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:32.868029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.747701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-oidc-hmac\" ","response":"range_response_count:1 size:452"} {"level":"info","ts":"2026-08-11T08:16:32.868064Z","caller":"traceutil/trace.go:171","msg":"trace[2084412782] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-oidc-hmac; range_end:; response_count:1; response_revision:1397; }","duration":"124.812844ms","start":"2026-08-11T08:16:32.743241Z","end":"2026-08-11T08:16:32.868054Z","steps":["trace[2084412782] 'agreement among raft nodes before linearized reading' (duration: 124.706191ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:32.868236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.205249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/kube-public/\" range_end:\"/registry/persistentvolumeclaims/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:16:32.868312Z","caller":"traceutil/trace.go:171","msg":"trace[559903457] range","detail":"{range_begin:/registry/persistentvolumeclaims/kube-public/; range_end:/registry/persistentvolumeclaims/kube-public0; response_count:0; response_revision:1397; }","duration":"107.319544ms","start":"2026-08-11T08:16:32.760972Z","end":"2026-08-11T08:16:32.868291Z","steps":["trace[559903457] 'agreement among raft nodes before linearized reading' (duration: 107.19709ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:16:37.010671Z","caller":"traceutil/trace.go:171","msg":"trace[1567483307] transaction","detail":"{read_only:false; response_revision:1410; number_of_response:1; }","duration":"129.290701ms","start":"2026-08-11T08:16:36.881346Z","end":"2026-08-11T08:16:37.010637Z","steps":["trace[1567483307] 'process raft request' (duration: 129.073883ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:16:37.016969Z","caller":"traceutil/trace.go:171","msg":"trace[1107751726] linearizableReadLoop","detail":"{readStateIndex:1473; appliedIndex:1471; }","duration":"119.467033ms","start":"2026-08-11T08:16:36.897477Z","end":"2026-08-11T08:16:37.016944Z","steps":["trace[1107751726] 'read index received' (duration: 112.972742ms)","trace[1107751726] 'applied index is now lower than readState.Index' (duration: 6.493391ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:16:37.017118Z","caller":"traceutil/trace.go:171","msg":"trace[1149937295] transaction","detail":"{read_only:false; response_revision:1411; number_of_response:1; }","duration":"132.229651ms","start":"2026-08-11T08:16:36.884852Z","end":"2026-08-11T08:16:37.017081Z","steps":["trace[1149937295] 'process raft request' (duration: 131.962024ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:37.017125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.627998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/kubeadm:nodes-kubeadm-config\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-08-11T08:16:37.0172Z","caller":"traceutil/trace.go:171","msg":"trace[251689450] range","detail":"{range_begin:/registry/rolebindings/kube-system/kubeadm:nodes-kubeadm-config; range_end:; response_count:1; response_revision:1411; }","duration":"119.742523ms","start":"2026-08-11T08:16:36.897445Z","end":"2026-08-11T08:16:37.017187Z","steps":["trace[251689450] 'agreement among raft nodes before linearized reading' (duration: 119.618259ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:37.017205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.98687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/kubeadm:kubelet-config\" ","response":"range_response_count:1 size:538"} {"level":"info","ts":"2026-08-11T08:16:37.017277Z","caller":"traceutil/trace.go:171","msg":"trace[733721166] range","detail":"{range_begin:/registry/rolebindings/kube-system/kubeadm:kubelet-config; range_end:; response_count:1; response_revision:1411; }","duration":"112.079073ms","start":"2026-08-11T08:16:36.905181Z","end":"2026-08-11T08:16:37.01726Z","steps":["trace[733721166] 'agreement among raft nodes before linearized reading' (duration: 111.942419ms)"],"step_count":1}