{"level":"warn","ts":"2026-06-05T16:01:51.718415Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-05T16:01:51.718537Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.78:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.78:2380","--initial-cluster=instance=https://199.204.45.78:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.78:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.78: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-06-05T16:01:51.718625Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-05T16:01:51.718651Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-06-05T16:01:51.718684Z","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-06-05T16:01:51.719301Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"]} {"level":"info","ts":"2026-06-05T16:01:51.719399Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.78: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-06-05T16:01:51.724451Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.842997ms"} {"level":"info","ts":"2026-06-05T16:01:51.731422Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6eb8766b1ec86e92","cluster-id":"9bbfe9e5d45d3718"} {"level":"info","ts":"2026-06-05T16:01:51.731555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=()"} {"level":"info","ts":"2026-06-05T16:01:51.731606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 0"} {"level":"info","ts":"2026-06-05T16:01:51.731637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6eb8766b1ec86e92 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-05T16:01:51.731671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 1"} {"level":"info","ts":"2026-06-05T16:01:51.731735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"warn","ts":"2026-06-05T16:01:51.742754Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-05T16:01:51.744029Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-05T16:01:51.745153Z","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-06-05T16:01:51.747407Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6eb8766b1ec86e92","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-05T16:01:51.752474Z","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-06-05T16:01:51.75281Z","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-06-05T16:01:51.756052Z","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-06-05T16:01:51.756022Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6eb8766b1ec86e92","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-05T16:01:51.756083Z","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-06-05T16:01:51.756787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"info","ts":"2026-06-05T16:01:51.756952Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","added-peer-id":"6eb8766b1ec86e92","added-peer-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-06-05T16:01:51.757421Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-06-05T16:01:51.757466Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-06-05T16:01:51.757741Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6eb8766b1ec86e92","initial-advertise-peer-urls":["https://199.204.45.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-05T16:01:51.757804Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-05T16:01:52.732464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 is starting a new election at term 1"} {"level":"info","ts":"2026-06-05T16:01:52.732525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-05T16:01:52.73257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgPreVoteResp from 6eb8766b1ec86e92 at term 1"} {"level":"info","ts":"2026-06-05T16:01:52.732844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became candidate at term 2"} {"level":"info","ts":"2026-06-05T16:01:52.732919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgVoteResp from 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-06-05T16:01:52.733006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became leader at term 2"} {"level":"info","ts":"2026-06-05T16:01:52.733032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6eb8766b1ec86e92 elected leader 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-06-05T16:01:52.734217Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-05T16:01:52.73454Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T16:01:52.735567Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T16:01:52.735702Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T16:01:52.735744Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T16:01:52.735711Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-05T16:01:52.73582Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-05T16:01:52.736043Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-05T16:01:52.734142Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6eb8766b1ec86e92","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.78:2379]}","request-path":"/0/members/6eb8766b1ec86e92/attributes","cluster-id":"9bbfe9e5d45d3718","publish-timeout":"7s"} {"level":"info","ts":"2026-06-05T16:01:52.737717Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-05T16:01:52.755202Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.78:2379"} {"level":"warn","ts":"2026-06-05T16:02:02.768463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.061308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:536"} {"level":"info","ts":"2026-06-05T16:02:02.768551Z","caller":"traceutil/trace.go:171","msg":"trace[116187689] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:307; }","duration":"126.232422ms","start":"2026-06-05T16:02:02.6423Z","end":"2026-06-05T16:02:02.768532Z","steps":["trace[116187689] 'range keys from in-memory index tree' (duration: 125.930003ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:02.768633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.481858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-06-05T16:02:02.768718Z","caller":"traceutil/trace.go:171","msg":"trace[1452861179] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:307; }","duration":"181.709289ms","start":"2026-06-05T16:02:02.586994Z","end":"2026-06-05T16:02:02.768703Z","steps":["trace[1452861179] 'range keys from in-memory index tree' (duration: 181.388572ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:02.768614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.325364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-05T16:02:02.76886Z","caller":"traceutil/trace.go:171","msg":"trace[1307624544] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:307; }","duration":"131.590104ms","start":"2026-06-05T16:02:02.637222Z","end":"2026-06-05T16:02:02.768812Z","steps":["trace[1307624544] 'range keys from in-memory index tree' (duration: 131.195609ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:02.768428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.148385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-06-05T16:02:02.769045Z","caller":"traceutil/trace.go:171","msg":"trace[569120901] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:307; }","duration":"126.80579ms","start":"2026-06-05T16:02:02.642223Z","end":"2026-06-05T16:02:02.769029Z","steps":["trace[569120901] 'range keys from in-memory index tree' (duration: 126.070508ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:04.592956Z","caller":"traceutil/trace.go:171","msg":"trace[1551051669] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"263.198609ms","start":"2026-06-05T16:02:04.32973Z","end":"2026-06-05T16:02:04.592929Z","steps":["trace[1551051669] 'process raft request' (duration: 263.056614ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:04.605855Z","caller":"traceutil/trace.go:171","msg":"trace[1473686054] linearizableReadLoop","detail":"{readStateIndex:367; appliedIndex:365; }","duration":"230.253003ms","start":"2026-06-05T16:02:04.375574Z","end":"2026-06-05T16:02:04.605827Z","steps":["trace[1473686054] 'read index received' (duration: 217.266883ms)","trace[1473686054] 'applied index is now lower than readState.Index' (duration: 12.982001ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T16:02:04.605962Z","caller":"traceutil/trace.go:171","msg":"trace[1531915330] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"274.283005ms","start":"2026-06-05T16:02:04.331659Z","end":"2026-06-05T16:02:04.605942Z","steps":["trace[1531915330] 'process raft request' (duration: 274.027703ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:04.606123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.526853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-qlw8j\" ","response":"range_response_count:1 size:4462"} {"level":"info","ts":"2026-06-05T16:02:04.606206Z","caller":"traceutil/trace.go:171","msg":"trace[332652929] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-qlw8j; range_end:; response_count:1; response_revision:358; }","duration":"230.64353ms","start":"2026-06-05T16:02:04.375544Z","end":"2026-06-05T16:02:04.606187Z","steps":["trace[332652929] 'agreement among raft nodes before linearized reading' (duration: 230.467246ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:07.685534Z","caller":"traceutil/trace.go:171","msg":"trace[539150421] linearizableReadLoop","detail":"{readStateIndex:381; appliedIndex:380; }","duration":"125.532958ms","start":"2026-06-05T16:02:07.559978Z","end":"2026-06-05T16:02:07.685511Z","steps":["trace[539150421] 'read index received' (duration: 83.212056ms)","trace[539150421] 'applied index is now lower than readState.Index' (duration: 42.320052ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T16:02:07.685713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.720712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T16:02:07.6857Z","caller":"traceutil/trace.go:171","msg":"trace[221961978] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"162.860225ms","start":"2026-06-05T16:02:07.522812Z","end":"2026-06-05T16:02:07.685673Z","steps":["trace[221961978] 'process raft request' (duration: 120.466366ms)","trace[221961978] 'compare' (duration: 42.111037ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T16:02:07.685751Z","caller":"traceutil/trace.go:171","msg":"trace[279043174] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:371; }","duration":"125.812459ms","start":"2026-06-05T16:02:07.559927Z","end":"2026-06-05T16:02:07.68574Z","steps":["trace[279043174] 'agreement among raft nodes before linearized reading' (duration: 125.671333ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:10.380565Z","caller":"traceutil/trace.go:171","msg":"trace[941827122] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"432.517776ms","start":"2026-06-05T16:02:09.948023Z","end":"2026-06-05T16:02:10.38054Z","steps":["trace[941827122] 'process raft request' (duration: 432.280762ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:10.381089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:09.948006Z","time spent":"432.631604ms","remote":"127.0.0.1:34154","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-06-05T16:02:11.651595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"668.124726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-05T16:02:11.651636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.090836976s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T16:02:11.651616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"931.811688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-05T16:02:11.651687Z","caller":"traceutil/trace.go:171","msg":"trace[34306533] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:378; }","duration":"668.257433ms","start":"2026-06-05T16:02:10.983411Z","end":"2026-06-05T16:02:11.651668Z","steps":["trace[34306533] 'range keys from in-memory index tree' (duration: 668.041308ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:11.651721Z","caller":"traceutil/trace.go:171","msg":"trace[115549355] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:378; }","duration":"1.090983203s","start":"2026-06-05T16:02:10.560719Z","end":"2026-06-05T16:02:11.651702Z","steps":["trace[115549355] 'range keys from in-memory index tree' (duration: 1.09070781s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:11.651745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:10.983393Z","time spent":"668.342821ms","remote":"127.0.0.1:34154","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-06-05T16:02:11.651761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:10.560691Z","time spent":"1.091061892s","remote":"127.0.0.1:33874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T16:02:11.651742Z","caller":"traceutil/trace.go:171","msg":"trace[2116416102] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:378; }","duration":"931.956785ms","start":"2026-06-05T16:02:10.719766Z","end":"2026-06-05T16:02:11.651723Z","steps":["trace[2116416102] 'range keys from in-memory index tree' (duration: 931.688721ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:11.65186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.191148ms","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-06-05T16:02:11.651914Z","caller":"traceutil/trace.go:171","msg":"trace[2058977559] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:378; }","duration":"570.402654ms","start":"2026-06-05T16:02:11.081492Z","end":"2026-06-05T16:02:11.651894Z","steps":["trace[2058977559] 'range keys from in-memory index tree' (duration: 570.08738ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:11.651954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:11.081468Z","time spent":"570.475902ms","remote":"127.0.0.1:34154","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-06-05T16:02:11.651961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:10.71974Z","time spent":"932.094612ms","remote":"127.0.0.1:34154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-05T16:02:12.244799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.3192ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-05T16:02:12.245073Z","caller":"traceutil/trace.go:171","msg":"trace[1230528210] linearizableReadLoop","detail":"{readStateIndex:389; appliedIndex:388; }","duration":"592.135664ms","start":"2026-06-05T16:02:11.652903Z","end":"2026-06-05T16:02:12.245039Z","steps":["trace[1230528210] 'read index received' (duration: 31.99µs)","trace[1230528210] 'applied index is now lower than readState.Index' (duration: 592.098574ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T16:02:12.245112Z","caller":"traceutil/trace.go:171","msg":"trace[382983459] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"588.607957ms","start":"2026-06-05T16:02:11.656466Z","end":"2026-06-05T16:02:12.245074Z","steps":["trace[382983459] 'process raft request' (duration: 588.46508ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:12.245238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:11.656442Z","time spent":"588.720844ms","remote":"127.0.0.1:34154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T16:02:12.245287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.354009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T16:02:12.245376Z","caller":"traceutil/trace.go:171","msg":"trace[33028763] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:379; }","duration":"592.488386ms","start":"2026-06-05T16:02:11.652868Z","end":"2026-06-05T16:02:12.245356Z","steps":["trace[33028763] 'agreement among raft nodes before linearized reading' (duration: 592.32222ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:12.245439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:11.652851Z","time spent":"592.579853ms","remote":"127.0.0.1:33858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T16:02:12.249533Z","caller":"traceutil/trace.go:171","msg":"trace[1649459781] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"593.00534ms","start":"2026-06-05T16:02:11.656516Z","end":"2026-06-05T16:02:12.249521Z","steps":["trace[1649459781] 'process raft request' (duration: 592.915302ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:12.249679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:11.656495Z","time spent":"593.069529ms","remote":"127.0.0.1:34154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T16:02:12.249709Z","caller":"traceutil/trace.go:171","msg":"trace[569852565] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"592.920803ms","start":"2026-06-05T16:02:11.656756Z","end":"2026-06-05T16:02:12.249677Z","steps":["trace[569852565] 'process raft request' (duration: 592.730237ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:12.249875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:11.65675Z","time spent":"593.03421ms","remote":"127.0.0.1:34154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T16:02:32.365601Z","caller":"traceutil/trace.go:171","msg":"trace[1643030915] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"237.254576ms","start":"2026-06-05T16:02:32.128322Z","end":"2026-06-05T16:02:32.365576Z","steps":["trace[1643030915] 'process raft request' (duration: 237.042226ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:32.376557Z","caller":"traceutil/trace.go:171","msg":"trace[1987858441] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"242.786543ms","start":"2026-06-05T16:02:32.133743Z","end":"2026-06-05T16:02:32.376529Z","steps":["trace[1987858441] 'process raft request' (duration: 240.38308ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:32.376626Z","caller":"traceutil/trace.go:171","msg":"trace[2103714229] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"232.442578ms","start":"2026-06-05T16:02:32.144173Z","end":"2026-06-05T16:02:32.376615Z","steps":["trace[2103714229] 'process raft request' (duration: 232.328468ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:32.376542Z","caller":"traceutil/trace.go:171","msg":"trace[1195783218] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"242.694213ms","start":"2026-06-05T16:02:32.133831Z","end":"2026-06-05T16:02:32.376525Z","steps":["trace[1195783218] 'process raft request' (duration: 242.615433ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:32.376965Z","caller":"traceutil/trace.go:171","msg":"trace[570664287] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"225.095398ms","start":"2026-06-05T16:02:32.151858Z","end":"2026-06-05T16:02:32.376954Z","steps":["trace[570664287] 'process raft request' (duration: 224.730897ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:32.377041Z","caller":"traceutil/trace.go:171","msg":"trace[323709750] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"232.98312ms","start":"2026-06-05T16:02:32.144022Z","end":"2026-06-05T16:02:32.377005Z","steps":["trace[323709750] 'process raft request' (duration: 232.453899ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:32.377087Z","caller":"traceutil/trace.go:171","msg":"trace[119605863] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"229.263234ms","start":"2026-06-05T16:02:32.147815Z","end":"2026-06-05T16:02:32.377078Z","steps":["trace[119605863] 'process raft request' (duration: 228.714343ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:32.377153Z","caller":"traceutil/trace.go:171","msg":"trace[1651996539] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"228.534594ms","start":"2026-06-05T16:02:32.148612Z","end":"2026-06-05T16:02:32.377146Z","steps":["trace[1651996539] 'process raft request' (duration: 227.942293ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:32.377314Z","caller":"traceutil/trace.go:171","msg":"trace[634905536] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"225.365298ms","start":"2026-06-05T16:02:32.151941Z","end":"2026-06-05T16:02:32.377306Z","steps":["trace[634905536] 'process raft request' (duration: 224.683327ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:32.377524Z","caller":"traceutil/trace.go:171","msg":"trace[303976855] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"192.571262ms","start":"2026-06-05T16:02:32.184931Z","end":"2026-06-05T16:02:32.377502Z","steps":["trace[303976855] 'process raft request' (duration: 191.956981ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:32.38264Z","caller":"traceutil/trace.go:171","msg":"trace[195496086] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"224.834828ms","start":"2026-06-05T16:02:32.157777Z","end":"2026-06-05T16:02:32.382612Z","steps":["trace[195496086] 'process raft request' (duration: 218.890669ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:33.437432Z","caller":"traceutil/trace.go:171","msg":"trace[588238702] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"124.5345ms","start":"2026-06-05T16:02:33.312868Z","end":"2026-06-05T16:02:33.437402Z","steps":["trace[588238702] 'process raft request' (duration: 123.524857ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:33.476448Z","caller":"traceutil/trace.go:171","msg":"trace[1977428607] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"112.997922ms","start":"2026-06-05T16:02:33.363431Z","end":"2026-06-05T16:02:33.476429Z","steps":["trace[1977428607] 'process raft request' (duration: 112.806032ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:38.741825Z","caller":"traceutil/trace.go:171","msg":"trace[613816324] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"165.228901ms","start":"2026-06-05T16:02:38.576577Z","end":"2026-06-05T16:02:38.741806Z","steps":["trace[613816324] 'process raft request' (duration: 165.10443ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:39.107459Z","caller":"traceutil/trace.go:171","msg":"trace[389032914] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"211.711797ms","start":"2026-06-05T16:02:38.895721Z","end":"2026-06-05T16:02:39.107433Z","steps":["trace[389032914] 'process raft request' (duration: 211.071781ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:40.164208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"970.760487ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-05T16:02:40.164383Z","caller":"traceutil/trace.go:171","msg":"trace[310033799] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:626; }","duration":"601.276383ms","start":"2026-06-05T16:02:39.563086Z","end":"2026-06-05T16:02:40.164362Z","steps":["trace[310033799] 'read index received' (duration: 68.17µs)","trace[310033799] 'applied index is now lower than readState.Index' (duration: 601.206403ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T16:02:40.164504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.415784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T16:02:40.164533Z","caller":"traceutil/trace.go:171","msg":"trace[1164759622] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:605; }","duration":"601.490924ms","start":"2026-06-05T16:02:39.563032Z","end":"2026-06-05T16:02:40.164523Z","steps":["trace[1164759622] 'agreement among raft nodes before linearized reading' (duration: 601.379063ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:40.164525Z","caller":"traceutil/trace.go:171","msg":"trace[1651788092] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"998.545971ms","start":"2026-06-05T16:02:39.165948Z","end":"2026-06-05T16:02:40.164494Z","steps":["trace[1651788092] 'process raft request' (duration: 27.397801ms)","trace[1651788092] 'compare' (duration: 970.559725ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T16:02:40.164718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:39.16592Z","time spent":"998.726812ms","remote":"127.0.0.1:34132","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-06-05T16:02:40.164563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:39.563011Z","time spent":"601.545986ms","remote":"127.0.0.1:33874","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-06-05T16:02:40.727268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.849361ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-05T16:02:40.727373Z","caller":"traceutil/trace.go:171","msg":"trace[2016364257] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:627; }","duration":"287.32597ms","start":"2026-06-05T16:02:40.44003Z","end":"2026-06-05T16:02:40.727355Z","steps":["trace[2016364257] 'read index received' (duration: 65.071µs)","trace[2016364257] 'applied index is now lower than readState.Index' (duration: 287.259209ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T16:02:40.727461Z","caller":"traceutil/trace.go:171","msg":"trace[1787013532] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"544.78179ms","start":"2026-06-05T16:02:40.182668Z","end":"2026-06-05T16:02:40.72745Z","steps":["trace[1787013532] 'process raft request' (duration: 131.679757ms)","trace[1787013532] 'compare' (duration: 412.65891ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T16:02:40.727513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:40.182654Z","time spent":"544.830471ms","remote":"127.0.0.1:34074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T16:02:40.72781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.965936ms","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-06-05T16:02:40.727899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.870274ms","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-06-05T16:02:40.727913Z","caller":"traceutil/trace.go:171","msg":"trace[1251696064] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:606; }","duration":"286.091617ms","start":"2026-06-05T16:02:40.441793Z","end":"2026-06-05T16:02:40.727885Z","steps":["trace[1251696064] 'agreement among raft nodes before linearized reading' (duration: 285.888745ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:40.727937Z","caller":"traceutil/trace.go:171","msg":"trace[910112625] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:606; }","duration":"287.971925ms","start":"2026-06-05T16:02:40.439954Z","end":"2026-06-05T16:02:40.727926Z","steps":["trace[910112625] 'agreement among raft nodes before linearized reading' (duration: 287.823933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:40.72799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.364498ms","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-06-05T16:02:40.72804Z","caller":"traceutil/trace.go:171","msg":"trace[152257678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:606; }","duration":"269.436618ms","start":"2026-06-05T16:02:40.458588Z","end":"2026-06-05T16:02:40.728025Z","steps":["trace[152257678] 'agreement among raft nodes before linearized reading' (duration: 269.245507ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:41.725984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.528198ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T16:02:41.726101Z","caller":"traceutil/trace.go:171","msg":"trace[38055908] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"993.780896ms","start":"2026-06-05T16:02:40.732305Z","end":"2026-06-05T16:02:41.726086Z","steps":["trace[38055908] 'process raft request' (duration: 414.104346ms)","trace[38055908] 'compare' (duration: 579.208455ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T16:02:41.726148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:40.732289Z","time spent":"993.839676ms","remote":"127.0.0.1:34154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T16:02:41.72633Z","caller":"traceutil/trace.go:171","msg":"trace[1547490963] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"993.382272ms","start":"2026-06-05T16:02:40.732939Z","end":"2026-06-05T16:02:41.726321Z","steps":["trace[1547490963] 'process raft request' (duration: 993.303041ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:41.726374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:40.732883Z","time spent":"993.469183ms","remote":"127.0.0.1:33956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T16:02:41.726396Z","caller":"traceutil/trace.go:171","msg":"trace[91381982] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"993.2109ms","start":"2026-06-05T16:02:40.733176Z","end":"2026-06-05T16:02:41.726387Z","steps":["trace[91381982] 'process raft request' (duration: 993.112189ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:41.726422Z","caller":"traceutil/trace.go:171","msg":"trace[118760520] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"992.890298ms","start":"2026-06-05T16:02:40.733521Z","end":"2026-06-05T16:02:41.726411Z","steps":["trace[118760520] 'process raft request' (duration: 992.821117ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:41.726442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:40.733167Z","time spent":"993.250612ms","remote":"127.0.0.1:34154","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-06-05T16:02:41.726483Z","caller":"traceutil/trace.go:171","msg":"trace[963653408] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"992.699847ms","start":"2026-06-05T16:02:40.733775Z","end":"2026-06-05T16:02:41.726474Z","steps":["trace[963653408] 'process raft request' (duration: 992.587275ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:41.726466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:40.733511Z","time spent":"992.93197ms","remote":"127.0.0.1:33956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T16:02:41.726524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:40.73375Z","time spent":"992.751148ms","remote":"127.0.0.1:34132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T16:02:41.726584Z","caller":"traceutil/trace.go:171","msg":"trace[1513407512] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"993.239252ms","start":"2026-06-05T16:02:40.733337Z","end":"2026-06-05T16:02:41.726576Z","steps":["trace[1513407512] 'process raft request' (duration: 992.981779ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:41.726624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:40.733302Z","time spent":"993.299472ms","remote":"127.0.0.1:34154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T16:02:41.726693Z","caller":"traceutil/trace.go:171","msg":"trace[1200754775] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"991.650897ms","start":"2026-06-05T16:02:40.735034Z","end":"2026-06-05T16:02:41.726685Z","steps":["trace[1200754775] 'process raft request' (duration: 991.372144ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:41.727718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:40.735002Z","time spent":"991.710959ms","remote":"127.0.0.1:34074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T16:02:41.732702Z","caller":"traceutil/trace.go:171","msg":"trace[2135473566] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:628; }","duration":"987.91755ms","start":"2026-06-05T16:02:40.744772Z","end":"2026-06-05T16:02:41.73269Z","steps":["trace[2135473566] 'read index received' (duration: 401.629415ms)","trace[2135473566] 'applied index is now lower than readState.Index' (duration: 586.285545ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T16:02:41.732859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"988.085821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-05T16:02:41.732869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.1289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T16:02:41.732909Z","caller":"traceutil/trace.go:171","msg":"trace[1711614274] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:613; }","duration":"988.169962ms","start":"2026-06-05T16:02:40.744729Z","end":"2026-06-05T16:02:41.732899Z","steps":["trace[1711614274] 'agreement among raft nodes before linearized reading' (duration: 988.037871ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:41.732923Z","caller":"traceutil/trace.go:171","msg":"trace[483110367] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:613; }","duration":"172.18441ms","start":"2026-06-05T16:02:41.560733Z","end":"2026-06-05T16:02:41.732917Z","steps":["trace[483110367] 'agreement among raft nodes before linearized reading' (duration: 172.109039ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:41.732934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:40.744715Z","time spent":"988.212592ms","remote":"127.0.0.1:34154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-05T16:02:57.435511Z","caller":"traceutil/trace.go:171","msg":"trace[422536176] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"185.015709ms","start":"2026-06-05T16:02:57.250472Z","end":"2026-06-05T16:02:57.435488Z","steps":["trace[422536176] 'process raft request' (duration: 184.879836ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:58.947651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.387747745s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-x7mxh\" ","response":"range_response_count:1 size:3964"} {"level":"warn","ts":"2026-06-05T16:02:58.947864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.156425773s","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-06-05T16:02:58.947988Z","caller":"traceutil/trace.go:171","msg":"trace[1135536333] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:768; }","duration":"1.156578006s","start":"2026-06-05T16:02:57.791382Z","end":"2026-06-05T16:02:58.94796Z","steps":["trace[1135536333] 'range keys from in-memory index tree' (duration: 1.1563118s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:58.948013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.191992808s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-05T16:02:58.948052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:57.791356Z","time spent":"1.156681428s","remote":"127.0.0.1:34154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-05T16:02:58.948098Z","caller":"traceutil/trace.go:171","msg":"trace[66307120] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:768; }","duration":"1.192114181s","start":"2026-06-05T16:02:57.755962Z","end":"2026-06-05T16:02:58.948076Z","steps":["trace[66307120] 'count revisions from in-memory index tree' (duration: 1.191923757s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:58.948198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:57.755937Z","time spent":"1.192244594s","remote":"127.0.0.1:34318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":2,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-06-05T16:02:58.948312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.146984203s","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-06-05T16:02:58.948324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.148720322s","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-06-05T16:02:58.948387Z","caller":"traceutil/trace.go:171","msg":"trace[1822310461] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:768; }","duration":"1.147670759s","start":"2026-06-05T16:02:57.800697Z","end":"2026-06-05T16:02:58.948368Z","steps":["trace[1822310461] 'range keys from in-memory index tree' (duration: 1.14683137s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:58.948465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:57.800688Z","time spent":"1.147757681s","remote":"127.0.0.1:34154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-05T16:02:58.947753Z","caller":"traceutil/trace.go:171","msg":"trace[1243353259] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-x7mxh; range_end:; response_count:1; response_revision:768; }","duration":"1.387891049s","start":"2026-06-05T16:02:57.559841Z","end":"2026-06-05T16:02:58.947732Z","steps":["trace[1243353259] 'range keys from in-memory index tree' (duration: 1.387550111s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:58.948585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:57.559825Z","time spent":"1.388742297s","remote":"127.0.0.1:34074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-x7mxh\" "} {"level":"info","ts":"2026-06-05T16:02:58.948649Z","caller":"traceutil/trace.go:171","msg":"trace[1812963643] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:768; }","duration":"1.14905691s","start":"2026-06-05T16:02:57.799371Z","end":"2026-06-05T16:02:58.948428Z","steps":["trace[1812963643] 'range keys from in-memory index tree' (duration: 1.148476407s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:58.94873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:57.79936Z","time spent":"1.149357267s","remote":"127.0.0.1:34154","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-06-05T16:02:58.948768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.144647142s","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-06-05T16:02:58.948821Z","caller":"traceutil/trace.go:171","msg":"trace[1612904499] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:768; }","duration":"1.144718444s","start":"2026-06-05T16:02:57.804088Z","end":"2026-06-05T16:02:58.948806Z","steps":["trace[1612904499] 'range keys from in-memory index tree' (duration: 1.14454953s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:58.948872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:57.804077Z","time spent":"1.144783066s","remote":"127.0.0.1:34154","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-06-05T16:02:59.064318Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967605068674922872,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-05T16:02:59.141033Z","caller":"traceutil/trace.go:171","msg":"trace[69351611] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"933.627211ms","start":"2026-06-05T16:02:58.207379Z","end":"2026-06-05T16:02:59.141006Z","steps":["trace[69351611] 'process raft request' (duration: 933.458617ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:59.141211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:58.207357Z","time spent":"933.756705ms","remote":"127.0.0.1:34068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5051,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T16:02:59.162003Z","caller":"traceutil/trace.go:171","msg":"trace[1063521023] linearizableReadLoop","detail":"{readStateIndex:803; appliedIndex:796; }","duration":"598.214976ms","start":"2026-06-05T16:02:58.56377Z","end":"2026-06-05T16:02:59.161985Z","steps":["trace[1063521023] 'read index received' (duration: 577.02305ms)","trace[1063521023] 'applied index is now lower than readState.Index' (duration: 21.190886ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T16:02:59.162242Z","caller":"traceutil/trace.go:171","msg":"trace[595109304] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"207.362286ms","start":"2026-06-05T16:02:58.954829Z","end":"2026-06-05T16:02:59.162192Z","steps":["trace[595109304] 'process raft request' (duration: 207.090599ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:59.162255Z","caller":"traceutil/trace.go:171","msg":"trace[201934667] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"209.121957ms","start":"2026-06-05T16:02:58.953116Z","end":"2026-06-05T16:02:59.162238Z","steps":["trace[201934667] 'process raft request' (duration: 208.727637ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:59.162292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.503475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T16:02:59.162353Z","caller":"traceutil/trace.go:171","msg":"trace[689718561] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"208.196746ms","start":"2026-06-05T16:02:58.954137Z","end":"2026-06-05T16:02:59.162334Z","steps":["trace[689718561] 'process raft request' (duration: 207.735465ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:59.162356Z","caller":"traceutil/trace.go:171","msg":"trace[918283352] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:775; }","duration":"598.616796ms","start":"2026-06-05T16:02:58.563722Z","end":"2026-06-05T16:02:59.162339Z","steps":["trace[918283352] 'agreement among raft nodes before linearized reading' (duration: 598.490073ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:02:59.162426Z","caller":"traceutil/trace.go:171","msg":"trace[314142654] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"207.93572ms","start":"2026-06-05T16:02:58.954483Z","end":"2026-06-05T16:02:59.162418Z","steps":["trace[314142654] 'process raft request' (duration: 207.412577ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:59.162412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.620047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T16:02:59.162389Z","caller":"traceutil/trace.go:171","msg":"trace[1444970656] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"639.683632ms","start":"2026-06-05T16:02:58.522634Z","end":"2026-06-05T16:02:59.162317Z","steps":["trace[1444970656] 'process raft request' (duration: 639.100957ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:59.162459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:58.563703Z","time spent":"598.74211ms","remote":"127.0.0.1:33874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T16:02:59.162482Z","caller":"traceutil/trace.go:171","msg":"trace[2006778406] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:775; }","duration":"468.742449ms","start":"2026-06-05T16:02:58.693731Z","end":"2026-06-05T16:02:59.162473Z","steps":["trace[2006778406] 'agreement among raft nodes before linearized reading' (duration: 468.631857ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:59.162506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:58.693709Z","time spent":"468.789031ms","remote":"127.0.0.1:34266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"info","ts":"2026-06-05T16:02:59.162587Z","caller":"traceutil/trace.go:171","msg":"trace[1979342549] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"206.772343ms","start":"2026-06-05T16:02:58.95566Z","end":"2026-06-05T16:02:59.162432Z","steps":["trace[1979342549] 'process raft request' (duration: 206.284291ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:02:59.16264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T16:02:58.522607Z","time spent":"639.890697ms","remote":"127.0.0.1:34154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T16:03:21.467859Z","caller":"traceutil/trace.go:171","msg":"trace[1667700078] linearizableReadLoop","detail":"{readStateIndex:1002; appliedIndex:1001; }","duration":"123.771166ms","start":"2026-06-05T16:03:21.344065Z","end":"2026-06-05T16:03:21.467836Z","steps":["trace[1667700078] 'read index received' (duration: 123.566129ms)","trace[1667700078] 'applied index is now lower than readState.Index' (duration: 203.467µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T16:03:21.467948Z","caller":"traceutil/trace.go:171","msg":"trace[124513598] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"136.002551ms","start":"2026-06-05T16:03:21.331899Z","end":"2026-06-05T16:03:21.467902Z","steps":["trace[124513598] 'process raft request' (duration: 135.779724ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:03:21.468129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.721484ms","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-06-05T16:03:21.468199Z","caller":"traceutil/trace.go:171","msg":"trace[1060756474] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:968; }","duration":"123.835328ms","start":"2026-06-05T16:03:21.344347Z","end":"2026-06-05T16:03:21.468182Z","steps":["trace[1060756474] 'agreement among raft nodes before linearized reading' (duration: 123.652332ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:03:21.468232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.254026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-05T16:03:21.468288Z","caller":"traceutil/trace.go:171","msg":"trace[1073550892] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:968; }","duration":"121.320319ms","start":"2026-06-05T16:03:21.346958Z","end":"2026-06-05T16:03:21.468278Z","steps":["trace[1073550892] 'agreement among raft nodes before linearized reading' (duration: 121.207605ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:03:21.468428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.363227ms","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-06-05T16:03:21.468471Z","caller":"traceutil/trace.go:171","msg":"trace[809238768] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:968; }","duration":"124.433939ms","start":"2026-06-05T16:03:21.344027Z","end":"2026-06-05T16:03:21.468461Z","steps":["trace[809238768] 'agreement among raft nodes before linearized reading' (duration: 123.909361ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:03:23.682212Z","caller":"traceutil/trace.go:171","msg":"trace[112829088] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"106.380694ms","start":"2026-06-05T16:03:23.575798Z","end":"2026-06-05T16:03:23.682179Z","steps":["trace[112829088] 'process raft request' (duration: 105.277834ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:03:53.819349Z","caller":"traceutil/trace.go:171","msg":"trace[407360638] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"180.487684ms","start":"2026-06-05T16:03:53.638823Z","end":"2026-06-05T16:03:53.81931Z","steps":["trace[407360638] 'process raft request' (duration: 179.720858ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:03:54.04886Z","caller":"traceutil/trace.go:171","msg":"trace[921634077] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"193.971874ms","start":"2026-06-05T16:03:53.854828Z","end":"2026-06-05T16:03:54.0488Z","steps":["trace[921634077] 'process raft request' (duration: 180.186948ms)","trace[921634077] 'compare' (duration: 13.375636ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T16:03:54.049329Z","caller":"traceutil/trace.go:171","msg":"trace[962230607] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"193.758354ms","start":"2026-06-05T16:03:53.855537Z","end":"2026-06-05T16:03:54.049296Z","steps":["trace[962230607] 'process raft request' (duration: 193.228879ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:03:54.049422Z","caller":"traceutil/trace.go:171","msg":"trace[874313258] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"129.047478ms","start":"2026-06-05T16:03:53.92035Z","end":"2026-06-05T16:03:54.049397Z","steps":["trace[874313258] 'process raft request' (duration: 128.864649ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:04:36.287756Z","caller":"traceutil/trace.go:171","msg":"trace[496267713] linearizableReadLoop","detail":"{readStateIndex:1266; appliedIndex:1265; }","duration":"225.010353ms","start":"2026-06-05T16:04:36.062721Z","end":"2026-06-05T16:04:36.287731Z","steps":["trace[496267713] 'read index received' (duration: 224.832362ms)","trace[496267713] 'applied index is now lower than readState.Index' (duration: 176.691µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T16:04:36.287835Z","caller":"traceutil/trace.go:171","msg":"trace[1930087289] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"230.744834ms","start":"2026-06-05T16:04:36.057073Z","end":"2026-06-05T16:04:36.287818Z","steps":["trace[1930087289] 'process raft request' (duration: 230.456977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:04:36.287985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.257007ms","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-06-05T16:04:36.288027Z","caller":"traceutil/trace.go:171","msg":"trace[377066764] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1217; }","duration":"225.346792ms","start":"2026-06-05T16:04:36.062668Z","end":"2026-06-05T16:04:36.288014Z","steps":["trace[377066764] 'agreement among raft nodes before linearized reading' (duration: 225.222975ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:04:36.288019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.925171ms","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-06-05T16:04:36.28807Z","caller":"traceutil/trace.go:171","msg":"trace[514253956] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1217; }","duration":"145.032177ms","start":"2026-06-05T16:04:36.143021Z","end":"2026-06-05T16:04:36.288053Z","steps":["trace[514253956] 'agreement among raft nodes before linearized reading' (duration: 144.895229ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:04:36.288102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.74156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-05T16:04:36.288479Z","caller":"traceutil/trace.go:171","msg":"trace[1848304750] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1217; }","duration":"123.156582ms","start":"2026-06-05T16:04:36.165311Z","end":"2026-06-05T16:04:36.288468Z","steps":["trace[1848304750] 'agreement among raft nodes before linearized reading' (duration: 122.653504ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:04:36.408661Z","caller":"traceutil/trace.go:171","msg":"trace[850488629] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"106.762395ms","start":"2026-06-05T16:04:36.301872Z","end":"2026-06-05T16:04:36.408635Z","steps":["trace[850488629] 'process raft request' (duration: 106.66324ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:04:36.408674Z","caller":"traceutil/trace.go:171","msg":"trace[303953669] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"116.156382ms","start":"2026-06-05T16:04:36.292487Z","end":"2026-06-05T16:04:36.408643Z","steps":["trace[303953669] 'process raft request' (duration: 71.332833ms)","trace[303953669] 'compare' (duration: 44.566264ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T16:04:36.531039Z","caller":"traceutil/trace.go:171","msg":"trace[353934936] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"117.75143ms","start":"2026-06-05T16:04:36.413254Z","end":"2026-06-05T16:04:36.531005Z","steps":["trace[353934936] 'process raft request' (duration: 104.303858ms)","trace[353934936] 'compare' (duration: 13.295023ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T16:04:38.64192Z","caller":"traceutil/trace.go:171","msg":"trace[840135744] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"130.181162ms","start":"2026-06-05T16:04:38.511712Z","end":"2026-06-05T16:04:38.641894Z","steps":["trace[840135744] 'process raft request' (duration: 115.263113ms)","trace[840135744] 'compare' (duration: 14.75531ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T16:04:38.642155Z","caller":"traceutil/trace.go:171","msg":"trace[88054154] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"130.412395ms","start":"2026-06-05T16:04:38.511722Z","end":"2026-06-05T16:04:38.642134Z","steps":["trace[88054154] 'process raft request' (duration: 130.127749ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:04:38.642084Z","caller":"traceutil/trace.go:171","msg":"trace[257120665] linearizableReadLoop","detail":"{readStateIndex:1277; appliedIndex:1275; }","duration":"116.352175ms","start":"2026-06-05T16:04:38.525703Z","end":"2026-06-05T16:04:38.642055Z","steps":["trace[257120665] 'read index received' (duration: 101.305459ms)","trace[257120665] 'applied index is now lower than readState.Index' (duration: 15.044516ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T16:04:38.642269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.539135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T16:04:38.64231Z","caller":"traceutil/trace.go:171","msg":"trace[2069547845] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1228; }","duration":"116.600938ms","start":"2026-06-05T16:04:38.525698Z","end":"2026-06-05T16:04:38.642299Z","steps":["trace[2069547845] 'agreement among raft nodes before linearized reading' (duration: 116.504973ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T16:04:38.642394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.155446ms","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-06-05T16:04:38.642418Z","caller":"traceutil/trace.go:171","msg":"trace[131335396] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1228; }","duration":"107.22245ms","start":"2026-06-05T16:04:38.535188Z","end":"2026-06-05T16:04:38.642411Z","steps":["trace[131335396] 'agreement among raft nodes before linearized reading' (duration: 107.123214ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T16:04:44.774764Z","caller":"traceutil/trace.go:171","msg":"trace[48803897] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"103.686773ms","start":"2026-06-05T16:04:44.67106Z","end":"2026-06-05T16:04:44.774747Z","steps":["trace[48803897] 'process raft request' (duration: 99.391448ms)"],"step_count":1}